builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0256 starttime: 1467800522.06 results: success (0) buildid: 20160706013523 builduid: bc102fa5c6bc4fc2bf8ed6ecd800ad68 revision: 94e6be97e007242cac69cd8331ce887345f4313c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.061954) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.062337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.062605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.252347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.252627) ========= 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.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-07-06 03:22:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-07-06 03:22:02 (15.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.482910 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.769622) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.769924) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.026510 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:02.818196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 03:22:02.818531) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 94e6be97e007242cac69cd8331ce887345f4313c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 94e6be97e007242cac69cd8331ce887345f4313c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-07-06 03:22:02,898 truncating revision to first 12 chars 2016-07-06 03:22:02,899 Setting DEBUG logging. 2016-07-06 03:22:02,899 attempt 1/10 2016-07-06 03:22:02,899 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/94e6be97e007?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 03:22:03,612 unpacking tar archive at: autoland-94e6be97e007/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000903 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 03:22:03.840073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:03.840524) ========= script_repo_revision: 94e6be97e007242cac69cd8331ce887345f4313c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:03.841124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:03.842039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 03:22:03.868852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-07-06 03:22:03.869314) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:22:04 INFO - MultiFileLogger online at 20160706 03:22:04 in /builds/slave/test 03:22:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:22:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:04 INFO - {'append_to_log': False, 03:22:04 INFO - 'base_work_dir': '/builds/slave/test', 03:22:04 INFO - 'blob_upload_branch': 'Autoland', 03:22:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:04 INFO - 'branch': 'Autoland', 03:22:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:04 INFO - 'config_files': ('talos/mac_config.py',), 03:22:04 INFO - 'default_actions': ('clobber', 03:22:04 INFO - 'read-buildbot-config', 03:22:04 INFO - 'download-and-extract', 03:22:04 INFO - 'populate-webroot', 03:22:04 INFO - 'create-virtualenv', 03:22:04 INFO - 'install', 03:22:04 INFO - 'run-tests'), 03:22:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:04 INFO - 'download_minidump_stackwalk': True, 03:22:04 INFO - 'download_symbols': 'ondemand', 03:22:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:04 INFO - 'installer_path': 'installer.exe', 03:22:04 INFO - 'log_level': 'info', 03:22:04 INFO - 'log_name': 'talos', 03:22:04 INFO - 'log_to_console': True, 03:22:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:22:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:22:04 INFO - 'opt_config_files': (), 03:22:04 INFO - 'pip_index': False, 03:22:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:04 INFO - 'cmd': ('bash', 03:22:04 INFO - '-c', 03:22:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:04 INFO - 'enabled': True, 03:22:04 INFO - 'halt_on_failure': False, 03:22:04 INFO - 'name': 'check_screen_resolution'},), 03:22:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:04 INFO - 'cmd': ('bash', 03:22:04 INFO - '-c', 03:22:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:04 INFO - 'enabled': True, 03:22:04 INFO - 'halt_on_failure': False, 03:22:04 INFO - 'name': 'check_screen_resolution'},), 03:22:04 INFO - 'run_cmd_checks_enabled': True, 03:22:04 INFO - 'sps_profile': False, 03:22:04 INFO - 'sps_profile_interval': 0, 03:22:04 INFO - 'suite': 'dromaeojs-e10s', 03:22:04 INFO - 'system_bits': '32', 03:22:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:04 INFO - 'title': 't-yosemite-r7-0256', 03:22:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:04 INFO - 'use_talos_json': True, 03:22:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:04 INFO - 'work_dir': 'build'} 03:22:04 INFO - ##### 03:22:04 INFO - ##### Running clobber step. 03:22:04 INFO - ##### 03:22:04 INFO - Running pre-action listener: _resource_record_pre_action 03:22:04 INFO - Running main action method: clobber 03:22:04 INFO - rmtree: /builds/slave/test/build 03:22:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:05 INFO - Running post-action listener: _resource_record_post_action 03:22:05 INFO - ##### 03:22:05 INFO - ##### Finished clobber step (success) 03:22:05 INFO - ##### 03:22:05 INFO - ##### 03:22:05 INFO - ##### Running read-buildbot-config step. 03:22:05 INFO - ##### 03:22:05 INFO - Running pre-action listener: _resource_record_pre_action 03:22:05 INFO - Running main action method: read_buildbot_config 03:22:05 INFO - Using buildbot properties: 03:22:05 INFO - { 03:22:05 INFO - "project": "", 03:22:05 INFO - "product": "firefox", 03:22:05 INFO - "script_repo_revision": "production", 03:22:05 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 03:22:05 INFO - "repository": "", 03:22:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 03:22:05 INFO - "buildid": "20160706013523", 03:22:05 INFO - "pgo_build": "False", 03:22:05 INFO - "basedir": "/builds/slave/test", 03:22:05 INFO - "buildnumber": 14, 03:22:05 INFO - "slavename": "t-yosemite-r7-0256", 03:22:05 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:22:05 INFO - "platform": "yosemite_r7", 03:22:05 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:22:05 INFO - "branch": "autoland", 03:22:05 INFO - "repo_path": "integration/autoland", 03:22:05 INFO - "revision": "94e6be97e007242cac69cd8331ce887345f4313c", 03:22:05 INFO - "stage_platform": "macosx64", 03:22:05 INFO - "builduid": "bc102fa5c6bc4fc2bf8ed6ecd800ad68", 03:22:05 INFO - "slavebuilddir": "test" 03:22:05 INFO - } 03:22:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 03:22:05 INFO - Running post-action listener: _resource_record_post_action 03:22:05 INFO - ##### 03:22:06 INFO - ##### Finished read-buildbot-config step (success) 03:22:06 INFO - ##### 03:22:06 INFO - ##### 03:22:06 INFO - ##### Running download-and-extract step. 03:22:06 INFO - ##### 03:22:06 INFO - Running pre-action listener: _resource_record_pre_action 03:22:06 INFO - Running main action method: download_and_extract 03:22:06 INFO - mkdir: /builds/slave/test/build/tests 03:22: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')]} 03:22:06 INFO - https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:22:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:22:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:22:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:22:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 03:22:07 INFO - Downloaded 1199 bytes. 03:22:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:22:07 INFO - Using the following test package requirements: 03:22:07 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:22:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 03:22:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 03:22:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'jsshell-mac.zip'], 03:22:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 03:22:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:22:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 03:22:07 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 03:22:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 03:22:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:22:07 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 03:22:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:07 INFO - https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:08 INFO - Downloaded 18804306 bytes. 03:22:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:22:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:22:11 INFO - Return code: 0 03:22:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:22: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')]} 03:22:11 INFO - https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:22:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip: timed out 03:22:41 INFO - retry: attempt #1 caught exception: timed out 03:22:41 INFO - retry: Failed, sleeping 30 seconds before retrying 03:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #2 03:23:13 INFO - Downloaded 18804306 bytes. 03:23:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:23:16 INFO - Return code: 0 03:23: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')]} 03:23:16 INFO - https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:23:18 INFO - Downloaded 14403333 bytes. 03:23:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:23:18 INFO - Return code: 0 03:23:18 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')]} 03:23:18 INFO - https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 03:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 03:23:22 INFO - Downloaded 112527522 bytes. 03:23:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:23:22 INFO - mkdir: /builds/slave/test/properties 03:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:22 INFO - Contents: 03:23:22 INFO - build_url:https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:23:22 INFO - Running post-action listener: _resource_record_post_action 03:23:22 INFO - Running post-action listener: set_extra_try_arguments 03:23:22 INFO - ##### 03:23:22 INFO - ##### Finished download-and-extract step (success) 03:23:22 INFO - ##### 03:23:22 INFO - ##### 03:23:22 INFO - ##### Running populate-webroot step. 03:23:22 INFO - ##### 03:23:22 INFO - Running pre-action listener: _resource_record_pre_action 03:23:22 INFO - Running main action method: populate_webroot 03:23:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:22 INFO - '--tppagecycles', 03:23:22 INFO - '7'], 03:23:22 INFO - 'tests': ['tsvgm']}}, 03:23:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['damp', 'tps']}, 03:23:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'tests': ['damp', 'tps']}, 03:23:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['dromaeo_dom']}, 03:23:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['basic_compositor_video']}, 03:23:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:23:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['a11yr', 03:23:22 INFO - 'ts_paint', 03:23:22 INFO - 'tpaint', 03:23:22 INFO - 'sessionrestore', 03:23:22 INFO - 'sessionrestore_no_auto_restore', 03:23:22 INFO - 'tabpaint']}, 03:23:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['tsvgx', 03:23:22 INFO - 'tsvgr_opacity', 03:23:22 INFO - 'tart', 03:23:22 INFO - 'tscrollx', 03:23:22 INFO - 'cart']}, 03:23:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:22 INFO - 'tsvgr_opacity', 03:23:22 INFO - 'tart', 03:23:22 INFO - 'tscrollx', 03:23:22 INFO - 'cart']}, 03:23:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'talos_options': ['--disable-e10s'], 03:23:22 INFO - 'tests': ['tp5o']}, 03:23:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'tests': ['tp5o']}, 03:23:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'talos_options': ['--disable-e10s', 03:23:22 INFO - '--xperf_path', 03:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:22 INFO - 'tests': ['tp5n']}, 03:23:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:22 INFO - 'talos_options': ['--xperf_path', 03:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:22 INFO - 'tests': ['tp5n']}}, 03:23:22 INFO - 'talos.zip': {'path': '', 03:23:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:22 INFO - Running post-action listener: _resource_record_post_action 03:23:22 INFO - ##### 03:23:22 INFO - ##### Finished populate-webroot step (success) 03:23:22 INFO - ##### 03:23:22 INFO - ##### 03:23:22 INFO - ##### Running create-virtualenv step. 03:23:22 INFO - ##### 03:23:22 INFO - Running pre-action listener: _resource_record_pre_action 03:23:22 INFO - Running main action method: create_virtualenv 03:23:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:22 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 03:23:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:22 INFO - Using real prefix '/tools/python27' 03:23:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:26 INFO - Installing pip.................done. 03:23:26 INFO - Return code: 0 03:23:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:26 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')]} 03:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 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')]} 03:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 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 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:26 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 03:23:26 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 03:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:26 INFO - 'HOME': '/Users/cltbld', 03:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:26 INFO - 'LOGNAME': 'cltbld', 03:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:26 INFO - 'MOZ_NO_REMOTE': '1', 03:23:26 INFO - 'NO_EM_RESTART': '1', 03:23:26 INFO - 'PAGER': '/bin/cat', 03:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:26 INFO - 'PWD': '/builds/slave/test', 03:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:26 INFO - 'SHELL': '/bin/bash', 03:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:26 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:26 INFO - 'USER': 'cltbld', 03:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:26 INFO - 'XPC_FLAGS': '0x0', 03:23:26 INFO - 'XPC_SERVICE_NAME': '0', 03:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:26 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 03:23:26 INFO - Cleaning up... 03:23:26 INFO - Return code: 0 03:23:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:26 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')]} 03:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 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')]} 03:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:26 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:26 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>=3.1.1'] in /builds/slave/test/build 03:23:26 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>=3.1.1 03:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:26 INFO - 'HOME': '/Users/cltbld', 03:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:26 INFO - 'LOGNAME': 'cltbld', 03:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:26 INFO - 'MOZ_NO_REMOTE': '1', 03:23:26 INFO - 'NO_EM_RESTART': '1', 03:23:26 INFO - 'PAGER': '/bin/cat', 03:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:26 INFO - 'PWD': '/builds/slave/test', 03:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:26 INFO - 'SHELL': '/bin/bash', 03:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:26 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:26 INFO - 'USER': 'cltbld', 03:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:26 INFO - 'XPC_FLAGS': '0x0', 03:23:26 INFO - 'XPC_SERVICE_NAME': '0', 03:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:26 INFO - Downloading/unpacking psutil>=3.1.1 03:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:30 INFO - Installing collected packages: psutil 03:23:30 INFO - Running setup.py install for psutil 03:23:30 INFO - building 'psutil._psutil_osx' extension 03:23:30 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 03:23:30 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 03:23:30 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 03:23:30 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 03:23:30 INFO - building 'psutil._psutil_posix' extension 03:23:30 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 03:23:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:23:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:23:30 INFO - ^ 03:23:30 INFO - 1 warning generated. 03:23:30 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 03:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:31 INFO - Successfully installed psutil 03:23:31 INFO - Cleaning up... 03:23:31 INFO - Return code: 0 03:23:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:31 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')]} 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:31 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')]} 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:31 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:31 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.3'] in /builds/slave/test/build 03:23:31 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.3 03:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:31 INFO - 'HOME': '/Users/cltbld', 03:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:31 INFO - 'LOGNAME': 'cltbld', 03:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:31 INFO - 'MOZ_NO_REMOTE': '1', 03:23:31 INFO - 'NO_EM_RESTART': '1', 03:23:31 INFO - 'PAGER': '/bin/cat', 03:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:31 INFO - 'PWD': '/builds/slave/test', 03:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:31 INFO - 'SHELL': '/bin/bash', 03:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:31 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:31 INFO - 'USER': 'cltbld', 03:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:31 INFO - 'XPC_FLAGS': '0x0', 03:23:31 INFO - 'XPC_SERVICE_NAME': '0', 03:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:31 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 03:23:31 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 03:23:31 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 03:23:31 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 03:23:31 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 03:23:31 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 03:23:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:33 INFO - Installing collected packages: mozsystemmonitor 03:23:33 INFO - Running setup.py install for mozsystemmonitor 03:23:34 INFO - Successfully installed mozsystemmonitor 03:23:34 INFO - Cleaning up... 03:23:34 INFO - Return code: 0 03:23:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:23:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:34 INFO - 'HOME': '/Users/cltbld', 03:23:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:34 INFO - 'LOGNAME': 'cltbld', 03:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:34 INFO - 'MOZ_NO_REMOTE': '1', 03:23:34 INFO - 'NO_EM_RESTART': '1', 03:23:34 INFO - 'PAGER': '/bin/cat', 03:23:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:34 INFO - 'PWD': '/builds/slave/test', 03:23:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:34 INFO - 'SHELL': '/bin/bash', 03:23:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:34 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:34 INFO - 'USER': 'cltbld', 03:23:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:34 INFO - 'XPC_FLAGS': '0x0', 03:23:34 INFO - 'XPC_SERVICE_NAME': '0', 03:23:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:36 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 03:23:36 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 03:23:36 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 03:23:36 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 03:23:36 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 03:23:36 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 03:23:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:37 INFO - warning: no files found matching '*.txt' 03:23:37 INFO - no previously-included directories found matching 'build' 03:23:37 INFO - no previously-included directories found matching 'dist' 03:23:37 INFO - no previously-included directories found matching '.git*' 03:23:37 INFO - Installing collected packages: jsonschema, functools32 03:23:37 INFO - Running setup.py install for functools32 03:23:37 INFO - warning: no files found matching '*.txt' 03:23:37 INFO - no previously-included directories found matching 'build' 03:23:37 INFO - no previously-included directories found matching 'dist' 03:23:37 INFO - no previously-included directories found matching '.git*' 03:23:37 INFO - Successfully installed jsonschema functools32 03:23:37 INFO - Cleaning up... 03:23:37 INFO - Return code: 0 03:23:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:37 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')]} 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:37 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')]} 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:37 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 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:37 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 03:23:37 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 03:23:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:37 INFO - 'HOME': '/Users/cltbld', 03:23:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:37 INFO - 'LOGNAME': 'cltbld', 03:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:37 INFO - 'MOZ_NO_REMOTE': '1', 03:23:37 INFO - 'NO_EM_RESTART': '1', 03:23:37 INFO - 'PAGER': '/bin/cat', 03:23:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:37 INFO - 'PWD': '/builds/slave/test', 03:23:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:37 INFO - 'SHELL': '/bin/bash', 03:23:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:37 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:37 INFO - 'USER': 'cltbld', 03:23:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:37 INFO - 'XPC_FLAGS': '0x0', 03:23:37 INFO - 'XPC_SERVICE_NAME': '0', 03:23:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 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 03:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - Downloading docopt-0.6.1.tar.gz 03:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:41 INFO - Running setup.py install for blobuploader 03:23:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:41 INFO - Running setup.py install for requests 03:23:42 INFO - Running setup.py install for docopt 03:23:42 INFO - Successfully installed blobuploader requests docopt 03:23:42 INFO - Cleaning up... 03:23:42 INFO - Return code: 0 03:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:42 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')]} 03:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:42 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')]} 03:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:42 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 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:42 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 03:23:42 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 03:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:42 INFO - 'HOME': '/Users/cltbld', 03:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:42 INFO - 'LOGNAME': 'cltbld', 03:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:42 INFO - 'MOZ_NO_REMOTE': '1', 03:23:42 INFO - 'NO_EM_RESTART': '1', 03:23:42 INFO - 'PAGER': '/bin/cat', 03:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:42 INFO - 'PWD': '/builds/slave/test', 03:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:42 INFO - 'SHELL': '/bin/bash', 03:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:42 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:42 INFO - 'USER': 'cltbld', 03:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:42 INFO - 'XPC_FLAGS': '0x0', 03:23:42 INFO - 'XPC_SERVICE_NAME': '0', 03:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:42 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-nTqJQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:42 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-5c3fd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:42 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-us6w0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-NdvzuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-JJuDeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-JWkPfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-xmxjgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-QR1xf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-lZwxog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-hcb5z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Dc5uMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-waYSlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:43 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Ge3om3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-yaTl3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Audx7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-CtIA2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:44 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-UoaWcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:44 INFO - Running setup.py install for manifestparser 03:23:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:44 INFO - Running setup.py install for mozcrash 03:23:44 INFO - Running setup.py install for mozdebug 03:23:44 INFO - Running setup.py install for mozdevice 03:23:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozfile 03:23:45 INFO - Running setup.py install for mozhttpd 03:23:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozinfo 03:23:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozInstall 03:23:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for mozleak 03:23:45 INFO - Running setup.py install for mozlog 03:23:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:45 INFO - Running setup.py install for moznetwork 03:23:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozprocess 03:23:46 INFO - Running setup.py install for mozprofile 03:23:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozrunner 03:23:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:46 INFO - Running setup.py install for mozscreenshot 03:23:46 INFO - Running setup.py install for moztest 03:23:46 INFO - Running setup.py install for mozversion 03:23:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:47 INFO - Cleaning up... 03:23:47 INFO - Return code: 0 03:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:47 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 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:47 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 03:23:47 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 03:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:47 INFO - 'HOME': '/Users/cltbld', 03:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:47 INFO - 'LOGNAME': 'cltbld', 03:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:47 INFO - 'MOZ_NO_REMOTE': '1', 03:23:47 INFO - 'NO_EM_RESTART': '1', 03:23:47 INFO - 'PAGER': '/bin/cat', 03:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:47 INFO - 'PWD': '/builds/slave/test', 03:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:47 INFO - 'SHELL': '/bin/bash', 03:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:47 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:47 INFO - 'USER': 'cltbld', 03:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:47 INFO - 'XPC_FLAGS': '0x0', 03:23:47 INFO - 'XPC_SERVICE_NAME': '0', 03:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-zJUJp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-DdTmLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-IXWJgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-lgVsGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LVIIc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-AleFKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:47 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)) 03:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:47 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-AWDFSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-EZfi2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-TTELC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-p_frl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-MAvKyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-JTbUzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-J5cu8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-t0QlW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-B0nnqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-rQv8Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:48 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)) 03:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:48 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-hIgLsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:49 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)) 03:23:49 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)) 03:23:49 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)) 03:23:49 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)) 03:23:49 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)) 03:23:49 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)) 03:23:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:49 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 03:23:49 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 03:23:49 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 03:23:49 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 03:23:49 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 03:23:49 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 03:23:51 INFO - Downloading blessings-1.6.tar.gz 03:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:51 INFO - Installing collected packages: blessings 03:23:51 INFO - Running setup.py install for blessings 03:23:51 INFO - Successfully installed blessings 03:23:51 INFO - Cleaning up... 03:23:51 INFO - Return code: 0 03:23:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:52 INFO - Reading from file tmpfile_stdout 03:23:52 INFO - Current package versions: 03:23:52 INFO - blessings == 1.6 03:23:52 INFO - blobuploader == 1.2.4 03:23:52 INFO - docopt == 0.6.1 03:23:52 INFO - functools32 == 3.2.3-2 03:23:52 INFO - jsonschema == 2.5.1 03:23:52 INFO - manifestparser == 1.1 03:23:52 INFO - mozInstall == 1.12 03:23:52 INFO - mozcrash == 0.17 03:23:52 INFO - mozdebug == 0.1 03:23:52 INFO - mozdevice == 0.48 03:23:52 INFO - mozfile == 1.2 03:23:52 INFO - mozhttpd == 0.7 03:23:52 INFO - mozinfo == 0.9 03:23:52 INFO - mozleak == 0.1 03:23:52 INFO - mozlog == 3.2 03:23:52 INFO - moznetwork == 0.27 03:23:52 INFO - mozprocess == 0.22 03:23:52 INFO - mozprofile == 0.28 03:23:52 INFO - mozrunner == 6.11 03:23:52 INFO - mozscreenshot == 0.1 03:23:52 INFO - mozsystemmonitor == 0.3 03:23:52 INFO - moztest == 0.7 03:23:52 INFO - mozversion == 1.4 03:23:52 INFO - psutil == 3.1.1 03:23:52 INFO - requests == 1.2.3 03:23:52 INFO - wsgiref == 0.1.2 03:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:52 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 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23:52 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 03:23:52 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 03:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:52 INFO - 'HOME': '/Users/cltbld', 03:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:52 INFO - 'LOGNAME': 'cltbld', 03:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:52 INFO - 'MOZ_NO_REMOTE': '1', 03:23:52 INFO - 'NO_EM_RESTART': '1', 03:23:52 INFO - 'PAGER': '/bin/cat', 03:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:52 INFO - 'PWD': '/builds/slave/test', 03:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:52 INFO - 'SHELL': '/bin/bash', 03:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:52 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:52 INFO - 'USER': 'cltbld', 03:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:52 INFO - 'XPC_FLAGS': '0x0', 03:23:52 INFO - 'XPC_SERVICE_NAME': '0', 03:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 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)) 03:23:52 INFO - Cleaning up... 03:23:52 INFO - Return code: 0 03:23:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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')]} 03:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024eaa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10257f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2bbc8ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, '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.zeq2eo3nhU/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.faT8JOCkaC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 03:23: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', 'jsonschema'] in /builds/slave/test/build 03:23: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 jsonschema 03:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:52 INFO - 'HOME': '/Users/cltbld', 03:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:52 INFO - 'LOGNAME': 'cltbld', 03:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:52 INFO - 'MOZ_NO_REMOTE': '1', 03:23:52 INFO - 'NO_EM_RESTART': '1', 03:23:52 INFO - 'PAGER': '/bin/cat', 03:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:52 INFO - 'PWD': '/builds/slave/test', 03:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:52 INFO - 'SHELL': '/bin/bash', 03:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:23:52 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:52 INFO - 'USER': 'cltbld', 03:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:52 INFO - 'XPC_FLAGS': '0x0', 03:23:52 INFO - 'XPC_SERVICE_NAME': '0', 03:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:52 INFO - Cleaning up... 03:23:52 INFO - Return code: 0 03:23:52 INFO - Running post-action listener: _resource_record_post_action 03:23:52 INFO - Running post-action listener: _start_resource_monitoring 03:23:52 INFO - Starting resource monitoring. 03:23:52 INFO - ##### 03:23:52 INFO - ##### Finished create-virtualenv step (success) 03:23:52 INFO - ##### 03:23:52 INFO - ##### 03:23:52 INFO - ##### Running install step. 03:23:52 INFO - ##### 03:23:52 INFO - Running pre-action listener: _resource_record_pre_action 03:23:52 INFO - Running main action method: install 03:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:52 INFO - Reading from file tmpfile_stdout 03:23:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:53 INFO - Reading from file tmpfile_stdout 03:23:53 INFO - Output received: 03:23:53 INFO - Usage: mozinstall [options] installer 03:23:53 INFO - Options: 03:23:53 INFO - -h, --help show this help message and exit 03:23:53 INFO - -d DEST, --destination=DEST 03:23:53 INFO - Directory to install application into. [default: 03:23:53 INFO - "/builds/slave/test"] 03:23:53 INFO - --app=APP Application being installed. [default: firefox] 03:23:53 INFO - mkdir: /builds/slave/test/build/application 03:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:24:28 INFO - Reading from file tmpfile_stdout 03:24:28 INFO - Output received: 03:24:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:24:28 INFO - Running post-action listener: _resource_record_post_action 03:24:28 INFO - ##### 03:24:28 INFO - ##### Finished install step (success) 03:24:28 INFO - ##### 03:24:28 INFO - ##### 03:24:28 INFO - ##### Running run-tests step. 03:24:28 INFO - ##### 03:24:28 INFO - Running pre-action listener: _resource_record_pre_action 03:24:28 INFO - Running main action method: run_tests 03:24:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:28 INFO - 2016-07-06 03:24:28.113 screenresolution[1647:7768] starting screenresolution argv=screenresolution get 03:24:28 INFO - 2016-07-06 03:24:28.115 screenresolution[1647:7768] Display 0: 1600x1200x32@60 03:24:28 INFO - 2016-07-06 03:24:28.121 screenresolution[1648:7770] starting screenresolution argv=screenresolution list 03:24:28 INFO - Available Modes on Display 0 03:24:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:28 INFO - Intel Iris: 03:24:28 INFO - Chipset Model: Intel Iris 03:24:28 INFO - Type: GPU 03:24:28 INFO - Bus: Built-In 03:24:28 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:28 INFO - Vendor: Intel (0x8086) 03:24:28 INFO - Device ID: 0x0a2e 03:24:28 INFO - Revision ID: 0x0009 03:24:28 INFO - Displays: 03:24:28 INFO - Display: 03:24:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:28 INFO - Display Serial Number: 1600x1200 60 03:24:28 INFO - Main Display: Yes 03:24:28 INFO - Mirror: Off 03:24:28 INFO - Online: Yes 03:24:28 INFO - Rotation: Supported 03:24:28 INFO - Return code: 0 03:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:28 INFO - Python 2.7.3 03:24:28 INFO - Return code: 0 03:24:28 INFO - grabbing minidump binary from tooltool 03:24:28 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')]} 03:24:28 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10244ed30>, '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 0x1021b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102446b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:28 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 03:24:28 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 03:24:28 INFO - Calling ['/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'] with output_timeout 600 03:24:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:28 INFO - Return code: 0 03:24:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:24:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:24:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zeq2eo3nhU/Render', 03:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:28 INFO - 'HOME': '/Users/cltbld', 03:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:28 INFO - 'LOGNAME': 'cltbld', 03:24:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:28 INFO - 'MOZ_NO_REMOTE': '1', 03:24:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:28 INFO - 'NO_EM_RESTART': '1', 03:24:28 INFO - 'PAGER': '/bin/cat', 03:24:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:28 INFO - 'PWD': '/builds/slave/test', 03:24:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:28 INFO - 'SHELL': '/bin/bash', 03:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.faT8JOCkaC/Listeners', 03:24:28 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 03:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:28 INFO - 'USER': 'cltbld', 03:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:28 INFO - 'XPC_FLAGS': '0x0', 03:24:28 INFO - 'XPC_SERVICE_NAME': '0', 03:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:24:28 INFO - mozversion application_buildid: 20160706013523 03:24:28 INFO - mozversion application_changeset: 94e6be97e007242cac69cd8331ce887345f4313c 03:24:28 INFO - mozversion application_display_name: Nightly 03:24:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:28 INFO - mozversion application_name: Firefox 03:24:28 INFO - mozversion application_remotingname: firefox 03:24:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:24:28 INFO - mozversion application_vendor: Mozilla 03:24:28 INFO - mozversion application_version: 50.0a1 03:24:28 INFO - mozversion platform_buildid: 20160706013523 03:24:28 INFO - mozversion platform_changeset: 94e6be97e007242cac69cd8331ce887345f4313c 03:24:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:24:28 INFO - mozversion platform_version: 50.0a1 03:24:28 INFO - using testdate: 1467800668 03:24:28 INFO - actual date: 1467800668 03:24:28 INFO - starting webserver on 'localhost:49269' 03:24:28 INFO - SUITE-START | Running 2 tests 03:24:28 INFO - TEST-START | dromaeo_css 03:24:28 INFO - operating with platform_type : mac_ 03:24:28 INFO - Initialising browser for dromaeo_css test... 03:24:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpUjp2t2/profile http://localhost:49269/getInfo.html) 03:24:31 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 03:24:31 INFO - PROCESS | 1658 | colorDepth:24 03:24:31 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 03:24:31 INFO - PROCESS | 1658 | __metrics 03:24:31 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 03:24:32 INFO - TEST-INFO | 1658: exit 0 03:24:32 INFO - Browser initialized. 03:24:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:32 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpUjp2t2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:44 INFO - PROCESS | 1662 | RSS: Main: 255680512 03:24:44 INFO - PROCESS | 1662 | 03:25:34 INFO - PROCESS | 1662 | 1467800734086 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] 03:27:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 03:27:46 INFO - PROCESS | 1662 | RSS: Main: 268005376 03:27:46 INFO - PROCESS | 1662 | 03:30:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 03:30:49 INFO - PROCESS | 1662 | RSS: Main: 276910080 03:30:49 INFO - PROCESS | 1662 | 03:33:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 03:33:52 INFO - PROCESS | 1662 | RSS: Main: 281436160 03:33:52 INFO - PROCESS | 1662 | 03:36:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 03:36:54 INFO - PROCESS | 1662 | RSS: Main: 280997888 03:36:54 INFO - PROCESS | 1662 | 03:39:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 03:39:57 INFO - PROCESS | 1662 | RSS: Main: 284323840 03:39:57 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 03:43:00 INFO - PROCESS | 1662 | RSS: Main: 284463104 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | __start_tp_report 03:43:00 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 03:43:00 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 03:43:00 INFO - PROCESS | 1662 | |i|pagename|runs| 03:43:00 INFO - PROCESS | 1662 | |0;dojo.html;3370.7977521348707;3379.6789305016023;3400.047986563762;3402.676745709157;3406.6593340665922;5742.28221472316;5808.59339846211;5863.58954873159;5871.579668352536;5919.112133180025;5233.927044955784;5590.18942253373;5621.409751976045;5684.090545512719;5840.941590584093;5255.789768409269;5296.867578310535;5348.705821179834;5360.463953604628;5404.810831620894;432.45826860833006;5305.7877684892555;5330.227117068022;5342.358916929974;5426.430224826396;4054.7567145971043;5266.762995665185;5282.31329927109;5305.336832895888;5331.680099194022;4715.009847931939;5205.791768329263;5273.34083239595;5328.227407025998;5356.11624082026;5228.189630607262;5243.842684719464;5265.736713164327;5268.367795864482;5298.417174110883;4656.301554766778;5466.043442397604;5860.589758716891;5909.586328956974;5987.191729116557;6152.969235153841;6201.689915504252;6227.657478838662;6316.273628532732;6325.96837015812;6222.346653601352;6283.214598175228;6287.056941458772;6300.054991751228;6305.527085468608;5957.106434034929;5964.194833697482;5973.462388385023;5975.820725378246;6013.6692481913915;6223.751049958041;6272.937270627235;6312.147860038928;6361.107510693234;6405.519586031066;6197.25632924052;6227.314995350508;6232.25212974446;6232.844178895473;6256.155419018465;6242.937570624326;6248.687565621701;6315;6316.989281714904;6317.557770956081;6176.69116544171;6202.81391558254;6235.064740288903;6252.812415627538;6277.843053923689;6172.722227499773;6201.565890387629;6284.340144284875;6307.022411526221;6310.716017779211;4971.676841005323;5028.120078986163;5042.193249080129;5053.191489361684;5071.54356107952;4432.867013989586;4434.866953991385;4453.977730111394;4454.064646424223;4550.49944506104;5921.911171332347;5978.760849566055;5992.191054207626;5998.3701711320555;6055.697215139314;6284;6302.590331628429;6322.841928951813;6336.936630633727;6375.330590288046;5791.739371728282;5919.112133180058;5961.910571341434;5982.132590774313;5984.598240936035;5534.723263836792;5535.58483113768;5537.916931246034;5544.112941929272;5557.77768889248;6487.351264873663;6492.870142597216;6516.511261655395;6523.575967562093;6533.869322613521;6194.938050619436;6208.9689551551955;6222.782202622887;6260;6333.20834895638;6501.382368674968;6517.804465866032;6535.57518761279;6552;6555.147830781968;6141.148492690724;6176.505879529716;6278.0269058296035;6285.842853928689;6331.778387756406;6226.62640241587;6237;6251.437370636664;6267.373262673696;6274.215723034621;4698.8355407560575;5641.915371269352;6025.969870150621;6169.907451388143;6213.502919766317;6047.244094488189;6100.702285530011;6219.378062193744;6229.314775374614;6268.153799237045;4988.301637770787;5524.75138618755;5925.555583331181;6057.7879774207695;6102.084687296941;6169.198004259418;6196.597221180609;6204.13142160089;6235.875282494416;6297.937020629918;5958.612690175125;6064.332923378513;6099.993501072273;6139.508839292756;6140.631562106288 03:43:00 INFO - PROCESS | 1662 | |1;ext.html;492.05034283832214;521.7964993652477;522.7464679630381;548.6707975214872;579.7478097027795;39586.60413395865;42694;42760.50338238162;42810;43064;40726.185476290455;43666.34500482495;44055;44189.337159942625;44958.32562511557;9589.089036541534;9764.658236961708;9764.951175244114;9780.972997835232;9820.852687209697;8730.301575873946;9698.951505242463;9701.320907536476;9789.510524473784;9805.754856128582;9733.367331123489;9762.902370976306;9775.462349570771;9809.705708828711;9826.70519884401;9681.951590242074;9710.902890971105;9720.805583888317;9786.5596048178;9815.263855210816;9696.75758106046;9767.755806104833;9789.657361992367;9802.509874506317;9808.95095524525;39560.80219598913;39669.00827479336;40490.59509404898;40773.1845363094;40835.38746918798;2953.778466614991;3435.5018522314376;3491.441369380887;3572.7141828653644;3590.8025058621765;30862.845685771652;31096.844515777502;31101;31170.552562997564;31862.840685796655;3161.2096975756062;3197.58431403916;3220.9677903221136;3248.6751324867323;3345.782524135948;389323;477690;478916.2108378906;480168;481821;35078.94763157109;35357.292854142775;35425.82287088548;35426.93719188429;35442.11394715101;32944;33084;33093.66906330954;33274;35984.28031439409;17163.828361716223;17274.740878886827;17383.565410864576;17401.825981740272;17409.129543522773;13034.869651303556;13089.952803775675;13142.27717475548;13171.538996135088;13173.60479185626;19785;19961.500962475762;20078.49803754918;20218.696719549218;20236.494087647927;8190.7133250335955;8209.76853471984;8239.95880020596;8260.586970651564;8280.875786863202;909.6361455417886;977.9119879210905;1035.8653375061194;1039.3555995282973;1039.4750650921387;30323.696763032527;31794.682053179637;31837.726490940568;32013.67986320107;32367.51448728271;1063.6170978447753;1083.7507373304184;1168.9649310520697;1182.1783860217238;1208.9395530223453;15011.624709382135;16333.26500307489;16469.929454585414;16477.670446591;16857.93391745361;570128;672290;684115;697903;699301.0069899338;52420;63263.36736632667;63418.68290658517;64274.67862660657;64386.67806660937;1383.8131852200027;1421.2396367943102;1424.1383962702623;1431.3701971132878;1432.8925330600246;26616.60075098914;31234.843825780725;31930;32203.838980804947;32545.511817322287;55289;55832.72083639556;55989.60025999383;56370;56469.43530564642;488411;497389.51305243245;514309;515170;518523;27608.309792255353;28269.43461130807;28280;28450.857745711968;28770.568441473813;50087;51653.96692066063;52286.73856630692;52474.737626311624;52919;42247.57752422436;42288.15423691447;42391.57608424;42986.785066074466;43989.78005109954;32994.505082423304;41516;41974.37038444487;42094.947626309586;42467;40956.38565421581;41129.79435102805;41360.58639413688;42124.5256416024;42361.94095147646;35060.29879402347;36566.63433365632;37056.629433706396;37340.25319493649;37764.81117594394;24567.365738049655;25033.249002529952;26629.46741065129;26864.462710745283;27042.594361084204 03:43:00 INFO - PROCESS | 1662 | |2;jquery.html;384.8768394113884;387.5098001028701;388.91541338426015;390.4943098687199;413.27882844436465;14975.625609359771;20587.897060514715;21199.682004769904;21872.671909921344;21901.342959711234;21146.471338216554;21488.462788430297;21580.784192158073;22245.777542224612;22264;5836.2121113649755;5905.232319798421;5920.052791553352;5926.199963004982;6058.818235452944;5605.411431799664;5957.106434034886;5968.522518198533;6079.300880398744;6094.725737341831;5735.4551317624755;5989.670568118751;6000.669963152025;6011.819645410645;6028.939710602882;5826.941730582725;5894.88210235795;5927.940720592782;6025.427584379477;6044.637321760686;5731.054376027951;5798.3911689272445;5823.883522329572;5839.620424672383;5848.795292164754;13811.17132972025;23094.884525577432;24082.91626876795;25562.616560751605;26474.338141546425;2102.8633138845926;2151.440625437382;2305.2853615379286;2352.694149760537;2940.3678209185127;8306.54314012729;10002.349847259904;10108.747281318027;10199.847002294971;10252.32033017978;1791.3192986665115;1802.7115661494097;1823.4529641107615;1831.5604254978844;1852.8795628284254;128202;133126;135330;135936;137517.31241343828;9639.951800240953;11627.59303424376;11677.941610291895;11752.177347585586;11828.645140645795;14525.854741452662;14722.337494812758;14796.926015369854;14800.111993280223;14816.629584260265;7212.855742885218;8645.481271123752;8713;8746.606402711766;8866.86699699505;7809.648565814438;8165.632546535301;8772.210501054935;8792.208701216794;8875.955620221857;4528.071745292207;4588.609968152745;4592.517785632527;4631.560001799824;4656.650751193674;1954.5602239496;1960.6764883794299;1962.9203937834134;2006.5585571174317;2018.3238615063824;822.0148341754715;902.5397047505688;921.9815603687889;925.9629614815332;1051.122312868748;19165.850048997105;19889.303874364326;20052.89973550123;21669.566608667737;21987.560248794933;911.8313112074287;941.0589410589411;993.3890657245742;1007.9899201007896;1030.7423144213947;9595.616175352907;11547.595834145932;11563.190576659554;11698.824517632242;11711.355875426932;574259;619562.8043719506;620308;628605;633119;79686;82198.17801822025;123343.383283083;134679;141051.5894841059;1008.9798204035878;1010.4897027001317;1014.5789497358661;1055.8785739640039;1063.276971659279;15648.374065037726;16566;18510.444686659423;19295.59861171298;19883.60232795365;57546.42453575411;57721.422785773284;58495;59102;59527;75131.24868751461;78771;87871.1212887863;88098;88234;7122.501424900207;7613.200613935457;8024.438289319692;8183.63173657175;8393.664253430039;12763.936180319039;13495.527656531975;13611;13632.591022269347;13662.726745464835;11623.535058597561;11637.418129093343;11653.359065251492;11758.176927614984;11850.689115622716;11372.54509819598;11547.884521154681;11649.534018639159;11651.533938642699;11678.182527223013;11790.882091179321;11792.41037948082;11857.16999810005;11908.106891982963;12203.816942746043;7467.813304667209;7604.277593628596;7662.080550333995;7665.6933722650465;7703.576303303372;9573.234141268822;11451.770964580828;11515.781826143828;11546.191766576596;11575.942120289345 03:43:00 INFO - PROCESS | 1662 | |3;mootools.html;1563.0934058246214;1610.1949025487256;1629.2424022829382;1669.590950217197;1795.9191836367363;8220.876686849702;8494.957525212372;8749.562521873897;9174.495402752838;9193.35646504745;8811.603477843497;8885.511296878669;8994.145556172169;8994.730158095252;9007.59465824038;2399.328188107324;2426.211481268595;2430.878456077198;2435.4641978764644;2436.488337449138;2410.373302941239;2411.602085655865;2430.6232533957264;2439.4389290463205;2444.144549407702;2384.701912260967;2411.963820542693;2423.8909249083745;2428.3200703802963;2440.987795061022;2389.5340408620327;2392.461696118377;2392.676988606533;2401.0875867170453;2410.9156179533807;2374.0978428197172;2381.0594815048134;2383.15398033699;2403.3510952043025;2405.5549723301247;9136.223421009223;9184.448933064037;9192.35653504255;9198.356115071947;9240.260779137652;5371.4897084776885;5398;5439.918401223985;5441.673499590037;5524.558035357162;3253;3365.9326813463595;3523.3834079036064;3592.46113083037;3592.6227746086547;1082.2370228988543;1085.1698450685233;1093.4040947683532;1105.171121658756;1106.634810512529;11715.941420292844;11860.703482412922;11873.643790686294;11873.703157421134;11891.464884080237;3983.322835117979;4660.650451216105;4868.002059577778;4886.389201349832;4889.902201955941;10092.646757363456;10123.1901447884;10126.088652021353;10129.240306977006;10132.746681332877;5422.620416570881;5475.890482190334;5480.342358916955;5483.204935284361;5488.7530061147345;4505.707129036602;4861.683990540603;4949.826756063592;5008.098542262355;5010.448850626428;3992.900177495586;4036.858709945138;4092.4884389451317;4126.979365103155;4135.276326642826;1310.8033794930836;1332.4803326702595;1338.090098732871;1341.7383610195918;1346.4748747988292;828.8093738440192;843.6414523827349;949.9382540135007;955.3312681123242;977.6333874796951;5452.209429632681;6159.5072394209255;6161.199044124235;6240.625562466266;6253.027390077687;881.532787622561;927.826299730841;944.6774515678105;945.3618807305041;1118.1334465789078;3594;4108.1783643271465;4150.979245103816;4239.47006624172;4278.914421711548;10663.73340666474;10931.836022459669;10990.945045274722;11063.72340691489;11070.225084244186;10796.892031079746;10914.617988370528;10961.83557246642;10963.50664220112;11027.338359698444;7872.724454643945;8422.368322375847;8553.529555874487;8555.230029297269;8685.739427817049;5682.346530149086;6125.663088530174;6140.877182456236;6283.937160628335;6333.543285044373;9999.400035997864;10389.220808439246;10408.739781505523;10420.635277765241;10432.791344173225;10366.118879895294;10664.360138391721;10686.305390149615;10692.732681683021;10708.464576770975;6391.616503009835;6917.13535808024;6944.895826562504;7180.461465390013;7277.235890231449;8324.62539185726;8354.164583541597;8362.540060296742;8419.11599282091;8501.14988501145;6300.558960872695;6868.072810170563;7500.887486687813;7669.7315593953945;7820.335271501986;7464;7464.440166987606;7547.773566793005;7623.771286861403;7647.273509016634;7069.081019467436;7146.249643787535;7170.354668079689;7184.748533801292;7185.137783466018;5032.773525191448;5204.141316682705;5251.081060814418;5263.763130659206;5267.236250743544;5199.532042116228;5223.425423203368;5274.630775845654;5294.9205761912835;5374.48942350476 03:43:00 INFO - PROCESS | 1662 | |4;prototype.html;290.1556470670349;318.14260567769855;319.73462026517984;319.9440097982854;325.59626063681014;5199.974000130003;5800.781835814484;5864.618799778012;5869.207656966309;5898.321693005306;4721.69308994916;5740.425957404257;5745.357135717564;5825.417458254173;5832.154337621042;3915.64910106013;3965.405189221611;4129.9174016519655;4226.661867050629;4296.892577685551;4212.1996820604145;4278.374217797233;4321.848735294266;4327;4335;4301.376300436435;4331.523532411432;4334.7862598472475;4334.869953901372;4342.196693611692;3465.1337165708574;4006.719529632927;4132.380142978547;4302.247106756305;4318.244307246219;3461.6153538584517;3665.6437118266144;3676.1251761601507;3683.8449507038413;3702.4816525686424;4559.723277482277;5271.894562108736;5581.995240856644;5591.41290164535;5654.46282603152;4425.225585522553;4456.796664900491;4623.110555902561;4858.955324605226;4958.429780575244;4765.737884416356;4934.629902757308;5369.62412631116;5713.800016999427;6019.187409699678;4017.2367250222364;4022.255882661717;4042.858499952517;4043.4541336919433;4052.63526282636;5171.405288391846;5852.590318677694;6096.305844499755;6373.26707428647;6460.386263305026;4076.898077548085;4109.198706252312;4121.711480196357;4129.027100487644;4137.958620413818;4180.393842892763;4188.623023927861;4189.287821070426;4190.53904070552;4190.559991200941;4741.83403580873;4960.355153830051;4979.502049794992;4987.650864439454;5001.224810154432;5275.340582427197;6065.090236464565;6102.047344849606;6108.725107370179;6120.265568131853;1395.5255213227551;1419.950301739434;1428.8071110399962;1430.4635761589404;1431.2628996067033;819.0016360081382;828.5732847583499;834.3492076180589;864.9913500865036;872.3936863879543;5557.722113894289;5600.859978500489;5607.327120745536;5619.690916999522;5621.100623900156;5382.089358277755;5426.8914621707345;5854.824355269348;5890.49930755882;6127.325994140641;4973.303737476756;5311.362636483646;5397.109476936262;5556.749731310423;5560.581147200981;2953.2173973896934;3047.5581040748966;3169.3819705157734;3264.4940034294723;3270.9018729438153;5995.850103747442;6226.816904788076;6253.622464275026;6375.2149398168585;6410.775622853178;5951.851203719855;6261.749530018748;6274.717637706314;6277.278113016971;6303.716332765037;5618.550515958714;6184.443400094013;6420.6789660517725;6443.838904027437;6453.386928241809;5794.420557944172;5813.709314534171;5976;6159.507239420746;6172.783952561639;4919.778609962632;5114.846554603368;5541.418151094077;6087.512998960161;6132.877342453036;5497.038018346853;6245.937540624535;6400.711967961546;6410.967945160244;6440;3418.67522585354;3627.510286111447;4041.090754580196;4048.676105911579;4085.1216988347646;5173;5478.424765399575;5973.132896209757;6134.601250918676;6231.626102433868;5666.575006874418;5798.362180160095;5939.970300148471;5943.405659434022;5960.807838432244;4941.258811178352;5952.702364881652;5977.880442391215;6007.339192688713;6012.278526576839;4926.4088309403105;5595.720213989365;5722.370539240764;5761.5102716269585;5863.296404431325;5756;6033.42682445167;6067.453929146398;6068.271807383142;6072.757089716361;5910.202122713378;5932.466078052996;5935.347111817783;5970.92523345802;5972.626295951868 03:43:00 INFO - PROCESS | 1662 | |5;yui.html;782.5930516131612;802.1497212954268;837.8722220013518;864.5633954852806;896.5786080542144;15264.313105910232;15538.989965652225;15639.218039098056;15861;15881.205939703012;14431.494897678584;14572.927135364309;14573.417063317482;14576.635584110403;14590.9786314958;532.7682458130706;810.7527204202715;875.9737207883774;914.2092090341873;923.3674932671108;788.8106854354971;840.9243168114868;893.6648756716231;899.0425197165031;904.7466709321368;807.9111297757271;935.9953200234023;970.5632465390568;973.9756506087334;974.2254907348639;965.0976337124811;966.6568368229283;967.4823969176457;967.9516024198797;970.6942313171328;696.5333226738097;700.4536461559991;715.1704023332961;725.0284618611087;725.2747252747253;15162.772558411632;15223.391064357524;15423;15425;15438.768418473732;10696.358218506915;13692.246926419042;13698.315084245747;13961.581152565439;14443.566692999228;11739;12048.698782530508;12157.93921030398;12177.817332740016;12436.875631243662;3874.767513949144;3916.5887581804072;3944.8027598619956;3972.5431575368625;4073.429719839195;117144.99999999914;120800;120963.99999999913;121078;121488.39255803752;11351.262167959056;11398.487068081957;11434.542618295342;11561.190716649753;11711.648650540497;22764;22963.311100667008;23232.3030309091;23283.650745238836;23288.88355558245;8215.09633940266;8265.628046737911;8269.379796515286;8310;8336.208060234268;4488.506264310923;4536.410266665378;4567.931481027787;4610.608098311681;4672.971946171905;3448.0862571418593;3548.2371290172737;3548.254866478017;3549.6095429502734;3556.5376501054698;674.3795707948699;680.306087790451;693.639307560066;696.4915611603558;701.0395757811831;559.5691317685441;615.5875563372551;631.7599312261403;660.5118221683671;702.304718328861;9657.565409556586;9663.710088697351;9672;9751.122398984126;9981.351212171186;572.9713514324267;683.2143035509204;697.1181455458849;706.7738323736355;709.4182770128446;4455.888602784957;4466.330050492452;4477.3731677565165;4493.123840851003;4501.658977910165;61664.45838853975;71561;72238.2776172242;97519;97842;108367.91632083736;112227;121588.78411215951;123179.3841030789;125794;85732;105109.89780204506;107000;107368;109448.45275773571;8441.451305665112;9215.677451289173;9218.492982886006;9265.629374824932;9848.803023939625;45837.08325833531;58231.70884145552;60257;61701;62929.68535157295;79045.60477197578;85914.70426478777;88616.556917215;90279.54860225657;90886.09113909041;12015.399230038638;13648.249346285653;13675.452981880613;13963.650908727363;14140.222287774272;15375.231238438257;15464;15666.608334791721;15724.68550629004;16342.591435214215;11298.830517542408;13773;13931.651708707363;13943.860561394662;14214.342471195621;13932;14288.071275367069;14496.275186240857;14851.851481485479;15061.548153555412;11948.34284114382;11982.460789264678;13662.658433539242;13712.588622341345;14342;10357.58200785369;11390.519232499722;11608.01331886799;11878.762424751629;11977.101717371057;11542.884571154182;11573.097155764219;11728.41357932117;11837.881621183678;11892.643220703392 03:43:00 INFO - PROCESS | 1662 | __end_tp_report 03:43:00 INFO - PROCESS | 1662 | __start_cc_report 03:43:00 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,445 03:43:00 INFO - PROCESS | 1662 | __end_cc_report 03:43:00 INFO - PROCESS | 1662 | __startTimestamp1467801780758__endTimestamp 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | ------- Summary: start ------- 03:43:00 INFO - PROCESS | 1662 | Number of tests: 6 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5770.13 Median:6055.70 stddev:795.00 (13.1%) stddev-sans-first:774.84 03:43:00 INFO - PROCESS | 1662 | Values: 3370.8 3379.7 3400.0 3402.7 3406.7 5742.3 5808.6 5863.6 5871.6 5919.1 5233.9 5590.2 5621.4 5684.1 5840.9 5255.8 5296.9 5348.7 5360.5 5404.8 432.5 5305.8 5330.2 5342.4 5426.4 4054.8 5266.8 5282.3 5305.3 5331.7 4715.0 5205.8 5273.3 5328.2 5356.1 5228.2 5243.8 5265.7 5268.4 5298.4 4656.3 5466.0 5860.6 5909.6 5987.2 6153.0 6201.7 6227.7 6316.3 6326.0 6222.3 6283.2 6287.1 6300.1 6305.5 5957.1 5964.2 5973.5 5975.8 6013.7 6223.8 6272.9 6312.1 6361.1 6405.5 6197.3 6227.3 6232.3 6232.8 6256.2 6242.9 6248.7 6315.0 6317.0 6317.6 6176.7 6202.8 6235.1 6252.8 6277.8 6172.7 6201.6 6284.3 6307.0 6310.7 4971.7 5028.1 5042.2 5053.2 5071.5 4432.9 4434.9 4454.0 4454.1 4550.5 5921.9 5978.8 5992.2 5998.4 6055.7 6284.0 6302.6 6322.8 6336.9 6375.3 5791.7 5919.1 5961.9 5982.1 5984.6 5534.7 5535.6 5537.9 5544.1 5557.8 6487.4 6492.9 6516.5 6523.6 6533.9 6194.9 6209.0 6222.8 6260.0 6333.2 6501.4 6517.8 6535.6 6552.0 6555.1 6141.1 6176.5 6278.0 6285.8 6331.8 6226.6 6237.0 6251.4 6267.4 6274.2 4698.8 5641.9 6026.0 6169.9 6213.5 6047.2 6100.7 6219.4 6229.3 6268.2 4988.3 5524.8 5925.6 6057.8 6102.1 6169.2 6196.6 6204.1 6235.9 6297.9 5958.6 6064.3 6100.0 6139.5 6140.6 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:67812.08 Median:40804.29 stddev:147604.32 (361.7%) stddev-sans-first:147931.85 03:43:00 INFO - PROCESS | 1662 | Values: 492.1 521.8 522.7 548.7 579.7 39586.6 42694.0 42760.5 42810.0 43064.0 40726.2 43666.3 44055.0 44189.3 44958.3 9589.1 9764.7 9765.0 9781.0 9820.9 8730.3 9699.0 9701.3 9789.5 9805.8 9733.4 9762.9 9775.5 9809.7 9826.7 9682.0 9710.9 9720.8 9786.6 9815.3 9696.8 9767.8 9789.7 9802.5 9809.0 39560.8 39669.0 40490.6 40773.2 40835.4 2953.8 3435.5 3491.4 3572.7 3590.8 30862.8 31096.8 31101.0 31170.6 31862.8 3161.2 3197.6 3221.0 3248.7 3345.8 389323.0 477690.0 478916.2 480168.0 481821.0 35078.9 35357.3 35425.8 35426.9 35442.1 32944.0 33084.0 33093.7 33274.0 35984.3 17163.8 17274.7 17383.6 17401.8 17409.1 13034.9 13090.0 13142.3 13171.5 13173.6 19785.0 19961.5 20078.5 20218.7 20236.5 8190.7 8209.8 8240.0 8260.6 8280.9 909.6 977.9 1035.9 1039.4 1039.5 30323.7 31794.7 31837.7 32013.7 32367.5 1063.6 1083.8 1169.0 1182.2 1208.9 15011.6 16333.3 16469.9 16477.7 16857.9 570128.0 672290.0 684115.0 697903.0 699301.0 52420.0 63263.4 63418.7 64274.7 64386.7 1383.8 1421.2 1424.1 1431.4 1432.9 26616.6 31234.8 31930.0 32203.8 32545.5 55289.0 55832.7 55989.6 56370.0 56469.4 488411.0 497389.5 514309.0 515170.0 518523.0 27608.3 28269.4 28280.0 28450.9 28770.6 50087.0 51654.0 52286.7 52474.7 52919.0 42247.6 42288.2 42391.6 42986.8 43989.8 32994.5 41516.0 41974.4 42094.9 42467.0 40956.4 41129.8 41360.6 42124.5 42361.9 35060.3 36566.6 37056.6 37340.3 37764.8 24567.4 25033.2 26629.5 26864.5 27042.6 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35815.33 Median:12700.08 stddev:102798.24 (809.4%) stddev-sans-first:103052.19 03:43:00 INFO - PROCESS | 1662 | Values: 384.9 387.5 388.9 390.5 413.3 14975.6 20587.9 21199.7 21872.7 21901.3 21146.5 21488.5 21580.8 22245.8 22264.0 5836.2 5905.2 5920.1 5926.2 6058.8 5605.4 5957.1 5968.5 6079.3 6094.7 5735.5 5989.7 6000.7 6011.8 6028.9 5826.9 5894.9 5927.9 6025.4 6044.6 5731.1 5798.4 5823.9 5839.6 5848.8 13811.2 23094.9 24082.9 25562.6 26474.3 2102.9 2151.4 2305.3 2352.7 2940.4 8306.5 10002.3 10108.7 10199.8 10252.3 1791.3 1802.7 1823.5 1831.6 1852.9 128202.0 133126.0 135330.0 135936.0 137517.3 9640.0 11627.6 11677.9 11752.2 11828.6 14525.9 14722.3 14796.9 14800.1 14816.6 7212.9 8645.5 8713.0 8746.6 8866.9 7809.6 8165.6 8772.2 8792.2 8876.0 4528.1 4588.6 4592.5 4631.6 4656.7 1954.6 1960.7 1962.9 2006.6 2018.3 822.0 902.5 922.0 926.0 1051.1 19165.9 19889.3 20052.9 21669.6 21987.6 911.8 941.1 993.4 1008.0 1030.7 9595.6 11547.6 11563.2 11698.8 11711.4 574259.0 619562.8 620308.0 628605.0 633119.0 79686.0 82198.2 123343.4 134679.0 141051.6 1009.0 1010.5 1014.6 1055.9 1063.3 15648.4 16566.0 18510.4 19295.6 19883.6 57546.4 57721.4 58495.0 59102.0 59527.0 75131.2 78771.0 87871.1 88098.0 88234.0 7122.5 7613.2 8024.4 8183.6 8393.7 12763.9 13495.5 13611.0 13632.6 13662.7 11623.5 11637.4 11653.4 11758.2 11850.7 11372.5 11547.9 11649.5 11651.5 11678.2 11790.9 11792.4 11857.2 11908.1 12203.8 7467.8 7604.3 7662.1 7665.7 7703.6 9573.2 11451.8 11515.8 11546.2 11575.9 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5835.56 Median:4888.15 stddev:3272.74 (67.0%) stddev-sans-first:3266.17 03:43:00 INFO - PROCESS | 1662 | Values: 1563.1 1610.2 1629.2 1669.6 1795.9 8220.9 8495.0 8749.6 9174.5 9193.4 8811.6 8885.5 8994.1 8994.7 9007.6 2399.3 2426.2 2430.9 2435.5 2436.5 2410.4 2411.6 2430.6 2439.4 2444.1 2384.7 2412.0 2423.9 2428.3 2441.0 2389.5 2392.5 2392.7 2401.1 2410.9 2374.1 2381.1 2383.2 2403.4 2405.6 9136.2 9184.4 9192.4 9198.4 9240.3 5371.5 5398.0 5439.9 5441.7 5524.6 3253.0 3365.9 3523.4 3592.5 3592.6 1082.2 1085.2 1093.4 1105.2 1106.6 11715.9 11860.7 11873.6 11873.7 11891.5 3983.3 4660.7 4868.0 4886.4 4889.9 10092.6 10123.2 10126.1 10129.2 10132.7 5422.6 5475.9 5480.3 5483.2 5488.8 4505.7 4861.7 4949.8 5008.1 5010.4 3992.9 4036.9 4092.5 4127.0 4135.3 1310.8 1332.5 1338.1 1341.7 1346.5 828.8 843.6 949.9 955.3 977.6 5452.2 6159.5 6161.2 6240.6 6253.0 881.5 927.8 944.7 945.4 1118.1 3594.0 4108.2 4151.0 4239.5 4278.9 10663.7 10931.8 10990.9 11063.7 11070.2 10796.9 10914.6 10961.8 10963.5 11027.3 7872.7 8422.4 8553.5 8555.2 8685.7 5682.3 6125.7 6140.9 6283.9 6333.5 9999.4 10389.2 10408.7 10420.6 10432.8 10366.1 10664.4 10686.3 10692.7 10708.5 6391.6 6917.1 6944.9 7180.5 7277.2 8324.6 8354.2 8362.5 8419.1 8501.1 6300.6 6868.1 7500.9 7669.7 7820.3 7464.0 7464.4 7547.8 7623.8 7647.3 7069.1 7146.2 7170.4 7184.7 7185.1 5032.8 5204.1 5251.1 5263.8 5267.2 5199.5 5223.4 5274.6 5294.9 5374.5 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4831.07 Median:5519.23 stddev:1500.74 (27.2%) stddev-sans-first:1465.74 03:43:00 INFO - PROCESS | 1662 | Values: 290.2 318.1 319.7 319.9 325.6 5200.0 5800.8 5864.6 5869.2 5898.3 4721.7 5740.4 5745.4 5825.4 5832.2 3915.6 3965.4 4129.9 4226.7 4296.9 4212.2 4278.4 4321.8 4327.0 4335.0 4301.4 4331.5 4334.8 4334.9 4342.2 3465.1 4006.7 4132.4 4302.2 4318.2 3461.6 3665.6 3676.1 3683.8 3702.5 4559.7 5271.9 5582.0 5591.4 5654.5 4425.2 4456.8 4623.1 4859.0 4958.4 4765.7 4934.6 5369.6 5713.8 6019.2 4017.2 4022.3 4042.9 4043.5 4052.6 5171.4 5852.6 6096.3 6373.3 6460.4 4076.9 4109.2 4121.7 4129.0 4138.0 4180.4 4188.6 4189.3 4190.5 4190.6 4741.8 4960.4 4979.5 4987.7 5001.2 5275.3 6065.1 6102.0 6108.7 6120.3 1395.5 1420.0 1428.8 1430.5 1431.3 819.0 828.6 834.3 865.0 872.4 5557.7 5600.9 5607.3 5619.7 5621.1 5382.1 5426.9 5854.8 5890.5 6127.3 4973.3 5311.4 5397.1 5556.7 5560.6 2953.2 3047.6 3169.4 3264.5 3270.9 5995.9 6226.8 6253.6 6375.2 6410.8 5951.9 6261.7 6274.7 6277.3 6303.7 5618.6 6184.4 6420.7 6443.8 6453.4 5794.4 5813.7 5976.0 6159.5 6172.8 4919.8 5114.8 5541.4 6087.5 6132.9 5497.0 6245.9 6400.7 6411.0 6440.0 3418.7 3627.5 4041.1 4048.7 4085.1 5173.0 5478.4 5973.1 6134.6 6231.6 5666.6 5798.4 5940.0 5943.4 5960.8 4941.3 5952.7 5977.9 6007.3 6012.3 4926.4 5595.7 5722.4 5761.5 5863.3 5756.0 6033.4 6067.5 6068.3 6072.8 5910.2 5932.5 5935.3 5970.9 5972.6 03:43:00 INFO - PROCESS | 1662 | 03:43:00 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:22672.97 Median:3930.70 stddev:34061.12 (866.5%) stddev-sans-first:34117.01 03:43:00 INFO - PROCESS | 1662 | Values: 782.6 802.1 837.9 864.6 896.6 15264.3 15539.0 15639.2 15861.0 15881.2 14431.5 14572.9 14573.4 14576.6 14591.0 532.8 810.8 876.0 914.2 923.4 788.8 840.9 893.7 899.0 904.7 807.9 936.0 970.6 974.0 974.2 965.1 966.7 967.5 968.0 970.7 696.5 700.5 715.2 725.0 725.3 15162.8 15223.4 15423.0 15425.0 15438.8 10696.4 13692.2 13698.3 13961.6 14443.6 11739.0 12048.7 12157.9 12177.8 12436.9 3874.8 3916.6 3944.8 3972.5 4073.4 117145.0 120800.0 120964.0 121078.0 121488.4 11351.3 11398.5 11434.5 11561.2 11711.6 22764.0 22963.3 23232.3 23283.7 23288.9 8215.1 8265.6 8269.4 8310.0 8336.2 4488.5 4536.4 4567.9 4610.6 4673.0 3448.1 3548.2 3548.3 3549.6 3556.5 674.4 680.3 693.6 696.5 701.0 559.6 615.6 631.8 660.5 702.3 9657.6 9663.7 9672.0 9751.1 9981.4 573.0 683.2 697.1 706.8 709.4 4455.9 4466.3 4477.4 4493.1 4501.7 61664.5 71561.0 72238.3 97519.0 97842.0 108367.9 112227.0 121588.8 123179.4 125794.0 85732.0 105109.9 107000.0 107368.0 109448.5 8441.5 9215.7 9218.5 9265.6 9848.8 45837.1 58231.7 60257.0 61701.0 62929.7 79045.6 85914.7 88616.6 90279.5 90886.1 12015.4 13648.2 13675.5 13963.7 14140.2 15375.2 15464.0 15666.6 15724.7 16342.6 11298.8 13773.0 13931.7 13943.9 14214.3 13932.0 14288.1 14496.3 14851.9 15061.5 11948.3 11982.5 13662.7 13712.6 14342.0 10357.6 11390.5 11608.0 11878.8 11977.1 11542.9 11573.1 11728.4 11837.9 11892.6 03:43:00 INFO - PROCESS | 1662 | -------- Summary: end -------- 03:43:00 INFO - PROCESS | 1662 | 03:43:01 INFO - TEST-INFO | 1662: exit 0 03:43:01 INFO - TEST-OK | dromaeo_css | took 1112619ms 03:43:01 INFO - TEST-START | kraken 03:43:01 INFO - operating with platform_type : mac_ 03:43:01 INFO - Initialising browser for kraken test... 03:43:01 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmp2agUrn/profile http://localhost:49269/getInfo.html) 03:43:04 INFO - PROCESS | 1692 | __metrics Screen width/height:1600/1200 03:43:04 INFO - PROCESS | 1692 | colorDepth:24 03:43:04 INFO - PROCESS | 1692 | Browser inner width/height: 1024/689 03:43:04 INFO - PROCESS | 1692 | __metrics 03:43:04 ERROR - PROCESS | 1692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 03:43:04 INFO - TEST-INFO | 1692: exit 0 03:43:04 INFO - Browser initialized. 03:43:04 INFO - Running cycle 1/1 for kraken test... 03:43:04 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmp2agUrn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:16 INFO - PROCESS | 1694 | RSS: Main: 255848448 03:43:16 INFO - PROCESS | 1694 | 03:43:19 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:20 INFO - PROCESS | 1694 | RSS: Main: 269234176 03:43:20 INFO - PROCESS | 1694 | 03:43:22 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 03:43:23 INFO - PROCESS | 1694 | RSS: Main: 272859136 03:43:23 INFO - PROCESS | 1694 | 03:43:26 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 03:43:27 INFO - PROCESS | 1694 | RSS: Main: 273108992 03:43:27 INFO - PROCESS | 1694 | 03:43:29 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 03:43:30 INFO - PROCESS | 1694 | RSS: Main: 273989632 03:43:30 INFO - PROCESS | 1694 | 03:43:32 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:32 INFO - PROCESS | 1694 | RSS: Main: 274702336 03:43:32 INFO - PROCESS | 1694 | 03:43:35 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:36 INFO - PROCESS | 1694 | RSS: Main: 275488768 03:43:36 INFO - PROCESS | 1694 | 03:43:39 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:39 INFO - PROCESS | 1694 | RSS: Main: 275791872 03:43:39 INFO - PROCESS | 1694 | 03:43:42 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 03:43:43 INFO - PROCESS | 1694 | RSS: Main: 276103168 03:43:43 INFO - PROCESS | 1694 | 03:43:45 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:45 INFO - PROCESS | 1694 | RSS: Main: 275668992 03:43:45 INFO - PROCESS | 1694 | 03:43:47 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:48 INFO - PROCESS | 1694 | RSS: Main: 275238912 03:43:48 INFO - PROCESS | 1694 | 03:43:50 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:51 INFO - PROCESS | 1694 | RSS: Main: 275456000 03:43:51 INFO - PROCESS | 1694 | 03:43:53 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:54 INFO - PROCESS | 1694 | RSS: Main: 275611648 03:43:54 INFO - PROCESS | 1694 | 03:43:57 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:58 INFO - PROCESS | 1694 | RSS: Main: 275525632 03:43:58 INFO - PROCESS | 1694 | 03:43:59 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 03:44:00 INFO - PROCESS | 1694 | RSS: Main: 276598784 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | __start_tp_report 03:44:00 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 03:44:00 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 03:44:00 INFO - PROCESS | 1694 | |i|pagename|runs| 03:44:00 INFO - PROCESS | 1694 | |0;ai-astar;105;116;108;128;166;118;114;114;116;118 03:44:00 INFO - PROCESS | 1694 | |1;audio-beat-detection;148;110;132;151;109;127;130;134;158;110 03:44:00 INFO - PROCESS | 1694 | |2;audio-dft;192;218;195;224;267;240;195;198;195;194 03:44:00 INFO - PROCESS | 1694 | |3;audio-fft;71;83;75;143;58;60;58;62;128;67 03:44:00 INFO - PROCESS | 1694 | |4;audio-oscillator;70;74;116;102;94;104;113;74;65;103 03:44:00 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;89;103;135;80;137;132;116;87;89;86 03:44:00 INFO - PROCESS | 1694 | |6;imaging-darkroom;94;96;95;98;94;99;95;98;95;94 03:44:00 INFO - PROCESS | 1694 | |7;imaging-desaturate;89;91;88;95;83;148;150;90;90;91 03:44:00 INFO - PROCESS | 1694 | |8;json-parse-financial;57;55;56;56;56;58;56;58;58;57 03:44:00 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;67;70;79;78;80;73;71;70;69;74 03:44:00 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;84;84;84;84;87;83;85;86;86;113 03:44:00 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;139;135;162;150;141;135;138;144;168;138 03:44:00 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;168;159;201;227;180;227;232;184;166;163 03:44:00 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;67;66;68;65;72;69;69;68;66;69 03:44:00 INFO - PROCESS | 1694 | __end_tp_report 03:44:00 INFO - PROCESS | 1694 | __start_cc_report 03:44:00 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,1117 03:44:00 INFO - PROCESS | 1694 | __end_cc_report 03:44:00 INFO - PROCESS | 1694 | __startTimestamp1467801840187__endTimestamp 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | ------- Summary: start ------- 03:44:00 INFO - PROCESS | 1694 | Number of tests: 14 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:120.30 Median:117.00 stddev:17.19 (14.7%) stddev-sans-first:17.32 03:44:00 INFO - PROCESS | 1694 | Values: 105.0 116.0 108.0 128.0 166.0 118.0 114.0 114.0 116.0 118.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:133.00 stddev:17.67 (13.3%) stddev-sans-first:17.63 03:44:00 INFO - PROCESS | 1694 | Values: 148.0 110.0 132.0 151.0 109.0 127.0 130.0 134.0 158.0 110.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:211.80 Median:208.00 stddev:25.33 (12.2%) stddev-sans-first:25.84 03:44:00 INFO - PROCESS | 1694 | Values: 192.0 218.0 195.0 224.0 267.0 240.0 195.0 198.0 195.0 194.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:80.50 Median:64.50 stddev:30.27 (46.9%) stddev-sans-first:31.91 03:44:00 INFO - PROCESS | 1694 | Values: 71.0 83.0 75.0 143.0 58.0 60.0 58.0 62.0 128.0 67.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:67.50 stddev:18.99 (28.1%) stddev-sans-first:18.48 03:44:00 INFO - PROCESS | 1694 | Values: 70.0 74.0 116.0 102.0 94.0 104.0 113.0 74.0 65.0 103.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:83.00 stddev:22.60 (27.2%) stddev-sans-first:23.18 03:44:00 INFO - PROCESS | 1694 | Values: 89.0 103.0 135.0 80.0 137.0 132.0 116.0 87.0 89.0 86.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:95.50 stddev:1.87 (2.0%) stddev-sans-first:1.87 03:44:00 INFO - PROCESS | 1694 | Values: 94.0 96.0 95.0 98.0 94.0 99.0 95.0 98.0 95.0 94.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:90.00 stddev:25.22 (28.0%) stddev-sans-first:26.34 03:44:00 INFO - PROCESS | 1694 | Values: 89.0 91.0 88.0 95.0 83.0 148.0 150.0 90.0 90.0 91.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 03:44:00 INFO - PROCESS | 1694 | Values: 57.0 55.0 56.0 56.0 56.0 58.0 56.0 58.0 58.0 57.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:73.50 stddev:4.53 (6.2%) stddev-sans-first:4.24 03:44:00 INFO - PROCESS | 1694 | Values: 67.0 70.0 79.0 78.0 80.0 73.0 71.0 70.0 69.0 74.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:9.01 (10.7%) stddev-sans-first:9.46 03:44:00 INFO - PROCESS | 1694 | Values: 84.0 84.0 84.0 84.0 87.0 83.0 85.0 86.0 86.0 113.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:142.50 stddev:11.52 (8.1%) stddev-sans-first:12.01 03:44:00 INFO - PROCESS | 1694 | Values: 139.0 135.0 162.0 150.0 141.0 135.0 138.0 144.0 168.0 138.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.70 Median:192.50 stddev:28.88 (15.0%) stddev-sans-first:29.44 03:44:00 INFO - PROCESS | 1694 | Values: 168.0 159.0 201.0 227.0 180.0 227.0 232.0 184.0 166.0 163.0 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:2.02 (3.0%) stddev-sans-first:2.12 03:44:00 INFO - PROCESS | 1694 | Values: 67.0 66.0 68.0 65.0 72.0 69.0 69.0 68.0 66.0 69.0 03:44:00 INFO - PROCESS | 1694 | -------- Summary: end -------- 03:44:00 INFO - PROCESS | 1694 | 03:44:00 INFO - TEST-INFO | 1694: exit 0 03:44:01 INFO - TEST-OK | kraken | took 59688ms 03:44:01 INFO - SUITE-END | took 1172s 03:44:01 INFO - Completed test suite (00:19:32) 03:44:01 INFO - javascript benchmark 03:44:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7495.525608234285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.7977521348707, 3379.6789305016023, 3400.047986563762, 3402.676745709157, 3406.6593340665922, 5742.28221472316, 5808.59339846211, 5863.58954873159, 5871.579668352536, 5919.112133180025, 5233.927044955784, 5590.18942253373, 5621.409751976045, 5684.090545512719, 5840.941590584093, 5255.789768409269, 5296.867578310535, 5348.705821179834, 5360.463953604628, 5404.810831620894, 432.45826860833006, 5305.7877684892555, 5330.227117068022, 5342.358916929974, 5426.430224826396, 4054.7567145971043, 5266.762995665185, 5282.31329927109, 5305.336832895888, 5331.680099194022, 4715.009847931939, 5205.791768329263, 5273.34083239595, 5328.227407025998, 5356.11624082026, 5228.189630607262, 5243.842684719464, 5265.736713164327, 5268.367795864482, 5298.417174110883, 4656.301554766778, 5466.043442397604, 5860.589758716891, 5909.586328956974, 5987.191729116557, 6152.969235153841, 6201.689915504252, 6227.657478838662, 6316.273628532732, 6325.96837015812, 6222.346653601352, 6283.214598175228, 6287.056941458772, 6300.054991751228, 6305.527085468608, 5957.106434034929, 5964.194833697482, 5973.462388385023, 5975.820725378246, 6013.6692481913915, 6223.751049958041, 6272.937270627235, 6312.147860038928, 6361.107510693234, 6405.519586031066, 6197.25632924052, 6227.314995350508, 6232.25212974446, 6232.844178895473, 6256.155419018465, 6242.937570624326, 6248.687565621701, 6315.0, 6316.989281714904, 6317.557770956081, 6176.69116544171, 6202.81391558254, 6235.064740288903, 6252.812415627538, 6277.843053923689, 6172.722227499773, 6201.565890387629, 6284.340144284875, 6307.022411526221, 6310.716017779211, 4971.676841005323, 5028.120078986163, 5042.193249080129, 5053.191489361684, 5071.54356107952, 4432.867013989586, 4434.866953991385, 4453.977730111394, 4454.064646424223, 4550.49944506104, 5921.911171332347, 5978.760849566055, 5992.191054207626, 5998.3701711320555, 6055.697215139314, 6284.0, 6302.590331628429, 6322.841928951813, 6336.936630633727, 6375.330590288046, 5791.739371728282, 5919.112133180058, 5961.910571341434, 5982.132590774313, 5984.598240936035, 5534.723263836792, 5535.58483113768, 5537.916931246034, 5544.112941929272, 5557.77768889248, 6487.351264873663, 6492.870142597216, 6516.511261655395, 6523.575967562093, 6533.869322613521, 6194.938050619436, 6208.9689551551955, 6222.782202622887, 6260.0, 6333.20834895638, 6501.382368674968, 6517.804465866032, 6535.57518761279, 6552.0, 6555.147830781968, 6141.148492690724, 6176.505879529716, 6278.0269058296035, 6285.842853928689, 6331.778387756406, 6226.62640241587, 6237.0, 6251.437370636664, 6267.373262673696, 6274.215723034621, 4698.8355407560575, 5641.915371269352, 6025.969870150621, 6169.907451388143, 6213.502919766317, 6047.244094488189, 6100.702285530011, 6219.378062193744, 6229.314775374614, 6268.153799237045, 4988.301637770787, 5524.75138618755, 5925.555583331181, 6057.7879774207695, 6102.084687296941, 6169.198004259418, 6196.597221180609, 6204.13142160089, 6235.875282494416, 6297.937020629918, 5958.612690175125, 6064.332923378513, 6099.993501072273, 6139.508839292756, 6140.631562106288], "value": 5721.511046166856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.05034283832214, 521.7964993652477, 522.7464679630381, 548.6707975214872, 579.7478097027795, 39586.60413395865, 42694.0, 42760.50338238162, 42810.0, 43064.0, 40726.185476290455, 43666.34500482495, 44055.0, 44189.337159942625, 44958.32562511557, 9589.089036541534, 9764.658236961708, 9764.951175244114, 9780.972997835232, 9820.852687209697, 8730.301575873946, 9698.951505242463, 9701.320907536476, 9789.510524473784, 9805.754856128582, 9733.367331123489, 9762.902370976306, 9775.462349570771, 9809.705708828711, 9826.70519884401, 9681.951590242074, 9710.902890971105, 9720.805583888317, 9786.5596048178, 9815.263855210816, 9696.75758106046, 9767.755806104833, 9789.657361992367, 9802.509874506317, 9808.95095524525, 39560.80219598913, 39669.00827479336, 40490.59509404898, 40773.1845363094, 40835.38746918798, 2953.778466614991, 3435.5018522314376, 3491.441369380887, 3572.7141828653644, 3590.8025058621765, 30862.845685771652, 31096.844515777502, 31101.0, 31170.552562997564, 31862.840685796655, 3161.2096975756062, 3197.58431403916, 3220.9677903221136, 3248.6751324867323, 3345.782524135948, 389323.0, 477690.0, 478916.2108378906, 480168.0, 481821.0, 35078.94763157109, 35357.292854142775, 35425.82287088548, 35426.93719188429, 35442.11394715101, 32944.0, 33084.0, 33093.66906330954, 33274.0, 35984.28031439409, 17163.828361716223, 17274.740878886827, 17383.565410864576, 17401.825981740272, 17409.129543522773, 13034.869651303556, 13089.952803775675, 13142.27717475548, 13171.538996135088, 13173.60479185626, 19785.0, 19961.500962475762, 20078.49803754918, 20218.696719549218, 20236.494087647927, 8190.7133250335955, 8209.76853471984, 8239.95880020596, 8260.586970651564, 8280.875786863202, 909.6361455417886, 977.9119879210905, 1035.8653375061194, 1039.3555995282973, 1039.4750650921387, 30323.696763032527, 31794.682053179637, 31837.726490940568, 32013.67986320107, 32367.51448728271, 1063.6170978447753, 1083.7507373304184, 1168.9649310520697, 1182.1783860217238, 1208.9395530223453, 15011.624709382135, 16333.26500307489, 16469.929454585414, 16477.670446591, 16857.93391745361, 570128.0, 672290.0, 684115.0, 697903.0, 699301.0069899338, 52420.0, 63263.36736632667, 63418.68290658517, 64274.67862660657, 64386.67806660937, 1383.8131852200027, 1421.2396367943102, 1424.1383962702623, 1431.3701971132878, 1432.8925330600246, 26616.60075098914, 31234.843825780725, 31930.0, 32203.838980804947, 32545.511817322287, 55289.0, 55832.72083639556, 55989.60025999383, 56370.0, 56469.43530564642, 488411.0, 497389.51305243245, 514309.0, 515170.0, 518523.0, 27608.309792255353, 28269.43461130807, 28280.0, 28450.857745711968, 28770.568441473813, 50087.0, 51653.96692066063, 52286.73856630692, 52474.737626311624, 52919.0, 42247.57752422436, 42288.15423691447, 42391.57608424, 42986.785066074466, 43989.78005109954, 32994.505082423304, 41516.0, 41974.37038444487, 42094.947626309586, 42467.0, 40956.38565421581, 41129.79435102805, 41360.58639413688, 42124.5256416024, 42361.94095147646, 35060.29879402347, 36566.63433365632, 37056.629433706396, 37340.25319493649, 37764.81117594394, 24567.365738049655, 25033.249002529952, 26629.46741065129, 26864.462710745283, 27042.594361084204], "value": 20034.15987204972, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.8768394113884, 387.5098001028701, 388.91541338426015, 390.4943098687199, 413.27882844436465, 14975.625609359771, 20587.897060514715, 21199.682004769904, 21872.671909921344, 21901.342959711234, 21146.471338216554, 21488.462788430297, 21580.784192158073, 22245.777542224612, 22264.0, 5836.2121113649755, 5905.232319798421, 5920.052791553352, 5926.199963004982, 6058.818235452944, 5605.411431799664, 5957.106434034886, 5968.522518198533, 6079.300880398744, 6094.725737341831, 5735.4551317624755, 5989.670568118751, 6000.669963152025, 6011.819645410645, 6028.939710602882, 5826.941730582725, 5894.88210235795, 5927.940720592782, 6025.427584379477, 6044.637321760686, 5731.054376027951, 5798.3911689272445, 5823.883522329572, 5839.620424672383, 5848.795292164754, 13811.17132972025, 23094.884525577432, 24082.91626876795, 25562.616560751605, 26474.338141546425, 2102.8633138845926, 2151.440625437382, 2305.2853615379286, 2352.694149760537, 2940.3678209185127, 8306.54314012729, 10002.349847259904, 10108.747281318027, 10199.847002294971, 10252.32033017978, 1791.3192986665115, 1802.7115661494097, 1823.4529641107615, 1831.5604254978844, 1852.8795628284254, 128202.0, 133126.0, 135330.0, 135936.0, 137517.31241343828, 9639.951800240953, 11627.59303424376, 11677.941610291895, 11752.177347585586, 11828.645140645795, 14525.854741452662, 14722.337494812758, 14796.926015369854, 14800.111993280223, 14816.629584260265, 7212.855742885218, 8645.481271123752, 8713.0, 8746.606402711766, 8866.86699699505, 7809.648565814438, 8165.632546535301, 8772.210501054935, 8792.208701216794, 8875.955620221857, 4528.071745292207, 4588.609968152745, 4592.517785632527, 4631.560001799824, 4656.650751193674, 1954.5602239496, 1960.6764883794299, 1962.9203937834134, 2006.5585571174317, 2018.3238615063824, 822.0148341754715, 902.5397047505688, 921.9815603687889, 925.9629614815332, 1051.122312868748, 19165.850048997105, 19889.303874364326, 20052.89973550123, 21669.566608667737, 21987.560248794933, 911.8313112074287, 941.0589410589411, 993.3890657245742, 1007.9899201007896, 1030.7423144213947, 9595.616175352907, 11547.595834145932, 11563.190576659554, 11698.824517632242, 11711.355875426932, 574259.0, 619562.8043719506, 620308.0, 628605.0, 633119.0, 79686.0, 82198.17801822025, 123343.383283083, 134679.0, 141051.5894841059, 1008.9798204035878, 1010.4897027001317, 1014.5789497358661, 1055.8785739640039, 1063.276971659279, 15648.374065037726, 16566.0, 18510.444686659423, 19295.59861171298, 19883.60232795365, 57546.42453575411, 57721.422785773284, 58495.0, 59102.0, 59527.0, 75131.24868751461, 78771.0, 87871.1212887863, 88098.0, 88234.0, 7122.501424900207, 7613.200613935457, 8024.438289319692, 8183.63173657175, 8393.664253430039, 12763.936180319039, 13495.527656531975, 13611.0, 13632.591022269347, 13662.726745464835, 11623.535058597561, 11637.418129093343, 11653.359065251492, 11758.176927614984, 11850.689115622716, 11372.54509819598, 11547.884521154681, 11649.534018639159, 11651.533938642699, 11678.182527223013, 11790.882091179321, 11792.41037948082, 11857.16999810005, 11908.106891982963, 12203.816942746043, 7467.813304667209, 7604.277593628596, 7662.080550333995, 7665.6933722650465, 7703.576303303372, 9573.234141268822, 11451.770964580828, 11515.781826143828, 11546.191766576596, 11575.942120289345], "value": 9694.822952988323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.0934058246214, 1610.1949025487256, 1629.2424022829382, 1669.590950217197, 1795.9191836367363, 8220.876686849702, 8494.957525212372, 8749.562521873897, 9174.495402752838, 9193.35646504745, 8811.603477843497, 8885.511296878669, 8994.145556172169, 8994.730158095252, 9007.59465824038, 2399.328188107324, 2426.211481268595, 2430.878456077198, 2435.4641978764644, 2436.488337449138, 2410.373302941239, 2411.602085655865, 2430.6232533957264, 2439.4389290463205, 2444.144549407702, 2384.701912260967, 2411.963820542693, 2423.8909249083745, 2428.3200703802963, 2440.987795061022, 2389.5340408620327, 2392.461696118377, 2392.676988606533, 2401.0875867170453, 2410.9156179533807, 2374.0978428197172, 2381.0594815048134, 2383.15398033699, 2403.3510952043025, 2405.5549723301247, 9136.223421009223, 9184.448933064037, 9192.35653504255, 9198.356115071947, 9240.260779137652, 5371.4897084776885, 5398.0, 5439.918401223985, 5441.673499590037, 5524.558035357162, 3253.0, 3365.9326813463595, 3523.3834079036064, 3592.46113083037, 3592.6227746086547, 1082.2370228988543, 1085.1698450685233, 1093.4040947683532, 1105.171121658756, 1106.634810512529, 11715.941420292844, 11860.703482412922, 11873.643790686294, 11873.703157421134, 11891.464884080237, 3983.322835117979, 4660.650451216105, 4868.002059577778, 4886.389201349832, 4889.902201955941, 10092.646757363456, 10123.1901447884, 10126.088652021353, 10129.240306977006, 10132.746681332877, 5422.620416570881, 5475.890482190334, 5480.342358916955, 5483.204935284361, 5488.7530061147345, 4505.707129036602, 4861.683990540603, 4949.826756063592, 5008.098542262355, 5010.448850626428, 3992.900177495586, 4036.858709945138, 4092.4884389451317, 4126.979365103155, 4135.276326642826, 1310.8033794930836, 1332.4803326702595, 1338.090098732871, 1341.7383610195918, 1346.4748747988292, 828.8093738440192, 843.6414523827349, 949.9382540135007, 955.3312681123242, 977.6333874796951, 5452.209429632681, 6159.5072394209255, 6161.199044124235, 6240.625562466266, 6253.027390077687, 881.532787622561, 927.826299730841, 944.6774515678105, 945.3618807305041, 1118.1334465789078, 3594.0, 4108.1783643271465, 4150.979245103816, 4239.47006624172, 4278.914421711548, 10663.73340666474, 10931.836022459669, 10990.945045274722, 11063.72340691489, 11070.225084244186, 10796.892031079746, 10914.617988370528, 10961.83557246642, 10963.50664220112, 11027.338359698444, 7872.724454643945, 8422.368322375847, 8553.529555874487, 8555.230029297269, 8685.739427817049, 5682.346530149086, 6125.663088530174, 6140.877182456236, 6283.937160628335, 6333.543285044373, 9999.400035997864, 10389.220808439246, 10408.739781505523, 10420.635277765241, 10432.791344173225, 10366.118879895294, 10664.360138391721, 10686.305390149615, 10692.732681683021, 10708.464576770975, 6391.616503009835, 6917.13535808024, 6944.895826562504, 7180.461465390013, 7277.235890231449, 8324.62539185726, 8354.164583541597, 8362.540060296742, 8419.11599282091, 8501.14988501145, 6300.558960872695, 6868.072810170563, 7500.887486687813, 7669.7315593953945, 7820.335271501986, 7464.0, 7464.440166987606, 7547.773566793005, 7623.771286861403, 7647.273509016634, 7069.081019467436, 7146.249643787535, 7170.354668079689, 7184.748533801292, 7185.137783466018, 5032.773525191448, 5204.141316682705, 5251.081060814418, 5263.763130659206, 5267.236250743544, 5199.532042116228, 5223.425423203368, 5274.630775845654, 5294.9205761912835, 5374.48942350476], "value": 4692.584040582312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1556470670349, 318.14260567769855, 319.73462026517984, 319.9440097982854, 325.59626063681014, 5199.974000130003, 5800.781835814484, 5864.618799778012, 5869.207656966309, 5898.321693005306, 4721.69308994916, 5740.425957404257, 5745.357135717564, 5825.417458254173, 5832.154337621042, 3915.64910106013, 3965.405189221611, 4129.9174016519655, 4226.661867050629, 4296.892577685551, 4212.1996820604145, 4278.374217797233, 4321.848735294266, 4327.0, 4335.0, 4301.376300436435, 4331.523532411432, 4334.7862598472475, 4334.869953901372, 4342.196693611692, 3465.1337165708574, 4006.719529632927, 4132.380142978547, 4302.247106756305, 4318.244307246219, 3461.6153538584517, 3665.6437118266144, 3676.1251761601507, 3683.8449507038413, 3702.4816525686424, 4559.723277482277, 5271.894562108736, 5581.995240856644, 5591.41290164535, 5654.46282603152, 4425.225585522553, 4456.796664900491, 4623.110555902561, 4858.955324605226, 4958.429780575244, 4765.737884416356, 4934.629902757308, 5369.62412631116, 5713.800016999427, 6019.187409699678, 4017.2367250222364, 4022.255882661717, 4042.858499952517, 4043.4541336919433, 4052.63526282636, 5171.405288391846, 5852.590318677694, 6096.305844499755, 6373.26707428647, 6460.386263305026, 4076.898077548085, 4109.198706252312, 4121.711480196357, 4129.027100487644, 4137.958620413818, 4180.393842892763, 4188.623023927861, 4189.287821070426, 4190.53904070552, 4190.559991200941, 4741.83403580873, 4960.355153830051, 4979.502049794992, 4987.650864439454, 5001.224810154432, 5275.340582427197, 6065.090236464565, 6102.047344849606, 6108.725107370179, 6120.265568131853, 1395.5255213227551, 1419.950301739434, 1428.8071110399962, 1430.4635761589404, 1431.2628996067033, 819.0016360081382, 828.5732847583499, 834.3492076180589, 864.9913500865036, 872.3936863879543, 5557.722113894289, 5600.859978500489, 5607.327120745536, 5619.690916999522, 5621.100623900156, 5382.089358277755, 5426.8914621707345, 5854.824355269348, 5890.49930755882, 6127.325994140641, 4973.303737476756, 5311.362636483646, 5397.109476936262, 5556.749731310423, 5560.581147200981, 2953.2173973896934, 3047.5581040748966, 3169.3819705157734, 3264.4940034294723, 3270.9018729438153, 5995.850103747442, 6226.816904788076, 6253.622464275026, 6375.2149398168585, 6410.775622853178, 5951.851203719855, 6261.749530018748, 6274.717637706314, 6277.278113016971, 6303.716332765037, 5618.550515958714, 6184.443400094013, 6420.6789660517725, 6443.838904027437, 6453.386928241809, 5794.420557944172, 5813.709314534171, 5976.0, 6159.507239420746, 6172.783952561639, 4919.778609962632, 5114.846554603368, 5541.418151094077, 6087.512998960161, 6132.877342453036, 5497.038018346853, 6245.937540624535, 6400.711967961546, 6410.967945160244, 6440.0, 3418.67522585354, 3627.510286111447, 4041.090754580196, 4048.676105911579, 4085.1216988347646, 5173.0, 5478.424765399575, 5973.132896209757, 6134.601250918676, 6231.626102433868, 5666.575006874418, 5798.362180160095, 5939.970300148471, 5943.405659434022, 5960.807838432244, 4941.258811178352, 5952.702364881652, 5977.880442391215, 6007.339192688713, 6012.278526576839, 4926.4088309403105, 5595.720213989365, 5722.370539240764, 5761.5102716269585, 5863.296404431325, 5756.0, 6033.42682445167, 6067.453929146398, 6068.271807383142, 6072.757089716361, 5910.202122713378, 5932.466078052996, 5935.347111817783, 5970.92523345802, 5972.626295951868], "value": 4340.484867317424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.5930516131612, 802.1497212954268, 837.8722220013518, 864.5633954852806, 896.5786080542144, 15264.313105910232, 15538.989965652225, 15639.218039098056, 15861.0, 15881.205939703012, 14431.494897678584, 14572.927135364309, 14573.417063317482, 14576.635584110403, 14590.9786314958, 532.7682458130706, 810.7527204202715, 875.9737207883774, 914.2092090341873, 923.3674932671108, 788.8106854354971, 840.9243168114868, 893.6648756716231, 899.0425197165031, 904.7466709321368, 807.9111297757271, 935.9953200234023, 970.5632465390568, 973.9756506087334, 974.2254907348639, 965.0976337124811, 966.6568368229283, 967.4823969176457, 967.9516024198797, 970.6942313171328, 696.5333226738097, 700.4536461559991, 715.1704023332961, 725.0284618611087, 725.2747252747253, 15162.772558411632, 15223.391064357524, 15423.0, 15425.0, 15438.768418473732, 10696.358218506915, 13692.246926419042, 13698.315084245747, 13961.581152565439, 14443.566692999228, 11739.0, 12048.698782530508, 12157.93921030398, 12177.817332740016, 12436.875631243662, 3874.767513949144, 3916.5887581804072, 3944.8027598619956, 3972.5431575368625, 4073.429719839195, 117144.99999999914, 120800.0, 120963.99999999913, 121078.0, 121488.39255803752, 11351.262167959056, 11398.487068081957, 11434.542618295342, 11561.190716649753, 11711.648650540497, 22764.0, 22963.311100667008, 23232.3030309091, 23283.650745238836, 23288.88355558245, 8215.09633940266, 8265.628046737911, 8269.379796515286, 8310.0, 8336.208060234268, 4488.506264310923, 4536.410266665378, 4567.931481027787, 4610.608098311681, 4672.971946171905, 3448.0862571418593, 3548.2371290172737, 3548.254866478017, 3549.6095429502734, 3556.5376501054698, 674.3795707948699, 680.306087790451, 693.639307560066, 696.4915611603558, 701.0395757811831, 559.5691317685441, 615.5875563372551, 631.7599312261403, 660.5118221683671, 702.304718328861, 9657.565409556586, 9663.710088697351, 9672.0, 9751.122398984126, 9981.351212171186, 572.9713514324267, 683.2143035509204, 697.1181455458849, 706.7738323736355, 709.4182770128446, 4455.888602784957, 4466.330050492452, 4477.3731677565165, 4493.123840851003, 4501.658977910165, 61664.45838853975, 71561.0, 72238.2776172242, 97519.0, 97842.0, 108367.91632083736, 112227.0, 121588.78411215951, 123179.3841030789, 125794.0, 85732.0, 105109.89780204506, 107000.0, 107368.0, 109448.45275773571, 8441.451305665112, 9215.677451289173, 9218.492982886006, 9265.629374824932, 9848.803023939625, 45837.08325833531, 58231.70884145552, 60257.0, 61701.0, 62929.68535157295, 79045.60477197578, 85914.70426478777, 88616.556917215, 90279.54860225657, 90886.09113909041, 12015.399230038638, 13648.249346285653, 13675.452981880613, 13963.650908727363, 14140.222287774272, 15375.231238438257, 15464.0, 15666.608334791721, 15724.68550629004, 16342.591435214215, 11298.830517542408, 13773.0, 13931.651708707363, 13943.860561394662, 14214.342471195621, 13932.0, 14288.071275367069, 14496.275186240857, 14851.851481485479, 15061.548153555412, 11948.34284114382, 11982.460789264678, 13662.658433539242, 13712.588622341345, 14342.0, 10357.58200785369, 11390.519232499722, 11608.01331886799, 11878.762424751629, 11977.101717371057, 11542.884571154182, 11573.097155764219, 11728.41357932117, 11837.881621183678, 11892.643220703392], "value": 7834.255350938133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 108.0, 128.0, 166.0, 118.0, 114.0, 114.0, 116.0, 118.0], "value": 120.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 132.0, 151.0, 109.0, 127.0, 130.0, 134.0, 158.0, 110.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 218.0, 195.0, 224.0, 267.0, 240.0, 195.0, 198.0, 195.0, 194.0], "value": 211.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 75.0, 143.0, 58.0, 60.0, 58.0, 62.0, 128.0, 67.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 116.0, 102.0, 94.0, 104.0, 113.0, 74.0, 65.0, 103.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 103.0, 135.0, 80.0, 137.0, 132.0, 116.0, 87.0, 89.0, 86.0], "value": 105.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 98.0, 94.0, 99.0, 95.0, 98.0, 95.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 88.0, 95.0, 83.0, 148.0, 150.0, 90.0, 90.0, 91.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 56.0, 58.0, 56.0, 58.0, 58.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 79.0, 78.0, 80.0, 73.0, 71.0, 70.0, 69.0, 74.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 87.0, 83.0, 85.0, 86.0, 86.0, 113.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 162.0, 150.0, 141.0, 135.0, 138.0, 144.0, 168.0, 138.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 201.0, 227.0, 180.0, 227.0, 232.0, 184.0, 166.0, 163.0], "value": 190.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 65.0, 72.0, 69.0, 69.0, 68.0, 66.0, 69.0], "value": 67.9, "unit": "score"}]}]} 03:44:01 INFO - Return code: 0 03:44:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:01 ERROR - # TBPL SUCCESS # 03:44:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:01 INFO - 2016-07-06 03:44:01.496 screenresolution[1699:10493] starting screenresolution argv=screenresolution get 03:44:01 INFO - 2016-07-06 03:44:01.498 screenresolution[1699:10493] Display 0: 1600x1200x32@60 03:44:01 INFO - 2016-07-06 03:44:01.504 screenresolution[1700:10496] starting screenresolution argv=screenresolution list 03:44:01 INFO - Available Modes on Display 0 03:44:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:01 INFO - Intel Iris: 03:44:01 INFO - Chipset Model: Intel Iris 03:44:01 INFO - Type: GPU 03:44:01 INFO - Bus: Built-In 03:44:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:01 INFO - Vendor: Intel (0x8086) 03:44:01 INFO - Device ID: 0x0a2e 03:44:01 INFO - Revision ID: 0x0009 03:44:01 INFO - Displays: 03:44:01 INFO - Display: 03:44:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:01 INFO - Display Serial Number: 1600x1200 60 03:44:01 INFO - Main Display: Yes 03:44:01 INFO - Mirror: Off 03:44:01 INFO - Online: Yes 03:44:01 INFO - Rotation: Supported 03:44:01 INFO - Return code: 0 03:44:01 INFO - Running post-action listener: _resource_record_post_action 03:44:01 INFO - ##### 03:44:01 INFO - ##### Finished run-tests step (success) 03:44:01 INFO - ##### 03:44:01 INFO - Running post-run listener: _resource_record_post_run 03:44:01 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31665664; Write bytes: 711320576; Read time: 192; Write time: 2002 03:44:01 INFO - TinderboxPrint: CPU usage
54.3% 03:44:01 INFO - TinderboxPrint: I/O read bytes / time
31,665,664 / 192 03:44:01 INFO - TinderboxPrint: I/O write bytes / time
711,320,576 / 2,002 03:44:01 INFO - TinderboxPrint: CPU idle
2,210.5 (45.7%) 03:44:01 INFO - TinderboxPrint: CPU system
975.0 (20.2%) 03:44:01 INFO - TinderboxPrint: CPU user
1,648.1 (34.1%) 03:44:01 INFO - TinderboxPrint: Swap in / out
434,601,984 / 0 03:44:01 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 400763392; Write bytes: 397346816; Read time: 31376; Write time: 813 03:44:01 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29593088; Write bytes: 294700032; Read time: 175; Write time: 1125 03:44:02 INFO - Running post-run listener: _upload_blobber_files 03:44:02 INFO - Blob upload gear active. 03:44:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:02 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 03:44:02 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:02 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:44:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:03 INFO - (blobuploader) - INFO - Done attempting. 03:44:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:44:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:04 INFO - (blobuploader) - INFO - Done attempting. 03:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:07 INFO - (blobuploader) - INFO - Done attempting. 03:44:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:07 INFO - Return code: 0 03:44:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/69574be9e9f8e2a79dc5346881a1f7fc545bc38a2315ac35603e299f379b74011fcbb99fcbcd4eb4bdb25246b926e72d12bc549c6d7547a5e098bdff2e0be3eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb1f3fce7b1c65882c9f1ee3b7fbdad508da00a8b67aca286f8b5713d027e096b9e73811aef6cc4718a239f856726f11c2dfa47d750068dc159c4a1704d827bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94e3ee6c6ae3836db3cbf9648a4495078f1b7a940170fff69f7166934d277b14a734d8aa66fb1b1cdc4bc5de2dabcf1f67d8f48ab4e6aa55a5f3129cc95aecbc"} 03:44:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:07 INFO - Contents: 03:44:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/69574be9e9f8e2a79dc5346881a1f7fc545bc38a2315ac35603e299f379b74011fcbb99fcbcd4eb4bdb25246b926e72d12bc549c6d7547a5e098bdff2e0be3eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb1f3fce7b1c65882c9f1ee3b7fbdad508da00a8b67aca286f8b5713d027e096b9e73811aef6cc4718a239f856726f11c2dfa47d750068dc159c4a1704d827bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94e3ee6c6ae3836db3cbf9648a4495078f1b7a940170fff69f7166934d277b14a734d8aa66fb1b1cdc4bc5de2dabcf1f67d8f48ab4e6aa55a5f3129cc95aecbc"} 03:44:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:07 INFO - Copying logs to upload dir... 03:44:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.239033 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-07-06 03:44:07.146448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 03:44:07.150108) ========= 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.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/69574be9e9f8e2a79dc5346881a1f7fc545bc38a2315ac35603e299f379b74011fcbb99fcbcd4eb4bdb25246b926e72d12bc549c6d7547a5e098bdff2e0be3eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb1f3fce7b1c65882c9f1ee3b7fbdad508da00a8b67aca286f8b5713d027e096b9e73811aef6cc4718a239f856726f11c2dfa47d750068dc159c4a1704d827bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94e3ee6c6ae3836db3cbf9648a4495078f1b7a940170fff69f7166934d277b14a734d8aa66fb1b1cdc4bc5de2dabcf1f67d8f48ab4e6aa55a5f3129cc95aecbc"} build_url:https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010825 build_url: 'https://queue.taskcluster.net/v1/task/apSptfXeRreQkdsaxhjddQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/69574be9e9f8e2a79dc5346881a1f7fc545bc38a2315ac35603e299f379b74011fcbb99fcbcd4eb4bdb25246b926e72d12bc549c6d7547a5e098bdff2e0be3eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb1f3fce7b1c65882c9f1ee3b7fbdad508da00a8b67aca286f8b5713d027e096b9e73811aef6cc4718a239f856726f11c2dfa47d750068dc159c4a1704d827bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/94e3ee6c6ae3836db3cbf9648a4495078f1b7a940170fff69f7166934d277b14a734d8aa66fb1b1cdc4bc5de2dabcf1f67d8f48ab4e6aa55a5f3129cc95aecbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 03:44:07.182497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:44:07.182848) ========= 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.zeq2eo3nhU/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.faT8JOCkaC/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.004998 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 03:44:07.231942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 03:44:07.232259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 03:44:07.232600) ========= ========= Total master_lag: 0.18 =========