builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1471349741.56 results: success (0) buildid: 20160816031824 builduid: ffddcfbe512d4f0182f44f9fb9ba8604 revision: bc160abe215baed95384cb10e17118b168caa05a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.555692) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.556101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.556371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.804120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.804435) ========= 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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-08-16 05:15:41-- 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% 45.6M=0s 2016-08-16 05:15:41 (45.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.949074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:41.949381) ========= 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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.027610 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:42.000278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:15:42.000673) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc160abe215baed95384cb10e17118b168caa05a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bc160abe215baed95384cb10e17118b168caa05a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-08-16 05:15:42,076 truncating revision to first 12 chars 2016-08-16 05:15:42,076 Setting DEBUG logging. 2016-08-16 05:15:42,076 attempt 1/10 2016-08-16 05:15:42,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc160abe215b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:15:43,546 unpacking tar archive at: fx-team-bc160abe215b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.747651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:15:43.769808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:43.770127) ========= script_repo_revision: bc160abe215baed95384cb10e17118b168caa05a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:43.770500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:43.770777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:15:43.789325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-16 05:15:43.789664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:15:43 INFO - MultiFileLogger online at 20160816 05:15:43 in /builds/slave/test 05:15:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:15:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:43 INFO - {'append_to_log': False, 05:15:43 INFO - 'base_work_dir': '/builds/slave/test', 05:15:43 INFO - 'blob_upload_branch': 'Fx-Team', 05:15:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:43 INFO - 'branch': 'Fx-Team', 05:15:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:43 INFO - 'config_files': ('talos/mac_config.py',), 05:15:43 INFO - 'default_actions': ('clobber', 05:15:43 INFO - 'read-buildbot-config', 05:15:43 INFO - 'download-and-extract', 05:15:43 INFO - 'populate-webroot', 05:15:43 INFO - 'create-virtualenv', 05:15:43 INFO - 'install', 05:15:43 INFO - 'run-tests'), 05:15:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:43 INFO - 'download_minidump_stackwalk': True, 05:15:43 INFO - 'download_symbols': 'ondemand', 05:15:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:43 INFO - 'installer_path': 'installer.exe', 05:15:43 INFO - 'log_level': 'info', 05:15:43 INFO - 'log_name': 'talos', 05:15:43 INFO - 'log_to_console': True, 05:15:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:43 INFO - 'opt_config_files': (), 05:15:43 INFO - 'pip_index': False, 05:15:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:43 INFO - 'cmd': ('bash', 05:15:43 INFO - '-c', 05:15:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:43 INFO - 'enabled': True, 05:15:43 INFO - 'halt_on_failure': False, 05:15:43 INFO - 'name': 'check_screen_resolution'},), 05:15:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:43 INFO - 'cmd': ('bash', 05:15:43 INFO - '-c', 05:15:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:43 INFO - 'enabled': True, 05:15:43 INFO - 'halt_on_failure': False, 05:15:43 INFO - 'name': 'check_screen_resolution'},), 05:15:43 INFO - 'run_cmd_checks_enabled': True, 05:15:43 INFO - 'sps_profile': False, 05:15:43 INFO - 'sps_profile_interval': 0, 05:15:43 INFO - 'suite': 'dromaeojs-e10s', 05:15:43 INFO - 'system_bits': '32', 05:15:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:43 INFO - 'title': 't-yosemite-r7-0106', 05:15:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:43 INFO - 'use_talos_json': True, 05:15:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:43 INFO - 'work_dir': 'build'} 05:15:43 INFO - [mozharness: 2016-08-16 12:15:43.983986Z] Running clobber step. 05:15:43 INFO - Running pre-action listener: _resource_record_pre_action 05:15:43 INFO - Running main action method: clobber 05:15:43 INFO - rmtree: /builds/slave/test/build 05:15:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:45 INFO - Running post-action listener: _resource_record_post_action 05:15:45 INFO - [mozharness: 2016-08-16 12:15:45.661688Z] Finished clobber step (success) 05:15:45 INFO - [mozharness: 2016-08-16 12:15:45.661814Z] Running read-buildbot-config step. 05:15:45 INFO - Running pre-action listener: _resource_record_pre_action 05:15:45 INFO - Running main action method: read_buildbot_config 05:15:45 INFO - Using buildbot properties: 05:15:45 INFO - { 05:15:45 INFO - "project": "", 05:15:45 INFO - "product": "firefox", 05:15:45 INFO - "script_repo_revision": "production", 05:15:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:15:45 INFO - "repository": "", 05:15:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:15:45 INFO - "buildid": "20160816031824", 05:15:45 INFO - "pgo_build": "False", 05:15:45 INFO - "basedir": "/builds/slave/test", 05:15:45 INFO - "buildnumber": 88, 05:15:45 INFO - "slavename": "t-yosemite-r7-0106", 05:15:45 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:15:45 INFO - "platform": "yosemite_r7", 05:15:45 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:15:45 INFO - "branch": "fx-team", 05:15:45 INFO - "repo_path": "integration/fx-team", 05:15:45 INFO - "revision": "bc160abe215baed95384cb10e17118b168caa05a", 05:15:45 INFO - "stage_platform": "macosx64", 05:15:45 INFO - "builduid": "ffddcfbe512d4f0182f44f9fb9ba8604", 05:15:45 INFO - "slavebuilddir": "test" 05:15:45 INFO - } 05:15:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:15:45 INFO - Running post-action listener: _resource_record_post_action 05:15:45 INFO - [mozharness: 2016-08-16 12:15:45.665146Z] Finished read-buildbot-config step (success) 05:15:45 INFO - [mozharness: 2016-08-16 12:15:45.665268Z] Running download-and-extract step. 05:15:45 INFO - Running pre-action listener: _resource_record_pre_action 05:15:45 INFO - Running main action method: download_and_extract 05:15:45 INFO - mkdir: /builds/slave/test/build/tests 05:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:45 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:15:45 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:15:46 INFO - Downloaded 1199 bytes. 05:15:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:15:46 INFO - Using the following test package requirements: 05:15:46 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:15:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:15:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'jsshell-mac.zip'], 05:15:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:15:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:15:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:15:46 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:15:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:15:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:46 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:46 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:47 INFO - Downloaded 16332055 bytes. 05:15:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:15:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:15:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:54 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:55 INFO - Downloaded 16332055 bytes. 05:15:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:01 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:16:01 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:03 INFO - Downloaded 14413719 bytes. 05:16:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:03 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:03 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:16:06 INFO - Downloaded 111109788 bytes. 05:16:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:06 INFO - mkdir: /builds/slave/test/properties 05:16:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:06 INFO - Contents: 05:16:06 INFO - build_url:https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:16:07 INFO - Running post-action listener: _resource_record_post_action 05:16:07 INFO - Running post-action listener: set_extra_try_arguments 05:16:07 INFO - [mozharness: 2016-08-16 12:16:07.172625Z] Finished download-and-extract step (success) 05:16:07 INFO - [mozharness: 2016-08-16 12:16:07.172795Z] Running populate-webroot step. 05:16:07 INFO - Running pre-action listener: _resource_record_pre_action 05:16:07 INFO - Running main action method: populate_webroot 05:16:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:07 INFO - '--tppagecycles', 05:16:07 INFO - '7'], 05:16:07 INFO - 'tests': ['tsvgm']}}, 05:16:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['damp', 'tps']}, 05:16:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'tests': ['damp', 'tps']}, 05:16:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['dromaeo_dom']}, 05:16:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['basic_compositor_video']}, 05:16:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tsvgx', 05:16:07 INFO - 'tsvgr_opacity', 05:16:07 INFO - 'tart', 05:16:07 INFO - 'tscrollx', 05:16:07 INFO - 'cart']}, 05:16:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:07 INFO - 'tsvgr_opacity', 05:16:07 INFO - 'tart', 05:16:07 INFO - 'tscrollx', 05:16:07 INFO - 'cart']}, 05:16:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tp5o']}, 05:16:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'tests': ['tp5o']}, 05:16:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s', 05:16:07 INFO - '--xperf_path', 05:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:07 INFO - 'tests': ['tp5n']}, 05:16:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:07 INFO - 'talos_options': ['--xperf_path', 05:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:07 INFO - 'tests': ['tp5n']}}, 05:16:07 INFO - 'talos.zip': {'path': '', 05:16:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:07 INFO - Running post-action listener: _resource_record_post_action 05:16:07 INFO - [mozharness: 2016-08-16 12:16:07.188003Z] Finished populate-webroot step (success) 05:16:07 INFO - [mozharness: 2016-08-16 12:16:07.188084Z] Running create-virtualenv step. 05:16:07 INFO - Running pre-action listener: _resource_record_pre_action 05:16:07 INFO - Running main action method: create_virtualenv 05:16:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:16:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:07 INFO - Using real prefix '/tools/python27' 05:16:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:11 INFO - Installing pip.................done. 05:16:11 INFO - Return code: 0 05:16:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:11 INFO - 'HOME': '/Users/cltbld', 05:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PAGER': '/bin/cat', 05:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:11 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - 'XPC_FLAGS': '0x0', 05:16:11 INFO - 'XPC_SERVICE_NAME': '0', 05:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:11 INFO - Cleaning up... 05:16:11 INFO - Return code: 0 05:16:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:11 INFO - 'HOME': '/Users/cltbld', 05:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PAGER': '/bin/cat', 05:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:11 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - 'XPC_FLAGS': '0x0', 05:16:11 INFO - 'XPC_SERVICE_NAME': '0', 05:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:11 INFO - Downloading/unpacking psutil>=3.1.1 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:14 INFO - Installing collected packages: psutil 05:16:14 INFO - Running setup.py install for psutil 05:16:14 INFO - building 'psutil._psutil_osx' extension 05:16:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:16:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:16:15 INFO - building 'psutil._psutil_posix' extension 05:16:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:16:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:15 INFO - ^ 05:16:15 INFO - 1 warning generated. 05:16:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:16:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:15 INFO - Successfully installed psutil 05:16:15 INFO - Cleaning up... 05:16:15 INFO - Return code: 0 05:16:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:15 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:15 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 05:16:15 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 05:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:15 INFO - 'HOME': '/Users/cltbld', 05:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PAGER': '/bin/cat', 05:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:15 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - 'XPC_FLAGS': '0x0', 05:16:15 INFO - 'XPC_SERVICE_NAME': '0', 05:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:18 INFO - Installing collected packages: mozsystemmonitor 05:16:18 INFO - Running setup.py install for mozsystemmonitor 05:16:18 INFO - Successfully installed mozsystemmonitor 05:16:18 INFO - Cleaning up... 05:16:18 INFO - Return code: 0 05:16:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:18 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:18 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 05:16:18 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 05:16:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:18 INFO - 'HOME': '/Users/cltbld', 05:16:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:18 INFO - 'LOGNAME': 'cltbld', 05:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:18 INFO - 'MOZ_NO_REMOTE': '1', 05:16:18 INFO - 'NO_EM_RESTART': '1', 05:16:18 INFO - 'PAGER': '/bin/cat', 05:16:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:18 INFO - 'PWD': '/builds/slave/test', 05:16:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:18 INFO - 'SHELL': '/bin/bash', 05:16:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:18 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:18 INFO - 'USER': 'cltbld', 05:16:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:18 INFO - 'XPC_FLAGS': '0x0', 05:16:18 INFO - 'XPC_SERVICE_NAME': '0', 05:16:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:21 INFO - warning: no files found matching '*.txt' 05:16:21 INFO - no previously-included directories found matching 'build' 05:16:21 INFO - no previously-included directories found matching 'dist' 05:16:21 INFO - no previously-included directories found matching '.git*' 05:16:21 INFO - Installing collected packages: jsonschema, functools32 05:16:22 INFO - Running setup.py install for functools32 05:16:22 INFO - warning: no files found matching '*.txt' 05:16:22 INFO - no previously-included directories found matching 'build' 05:16:22 INFO - no previously-included directories found matching 'dist' 05:16:22 INFO - no previously-included directories found matching '.git*' 05:16:22 INFO - Successfully installed jsonschema functools32 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:22 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:16:22 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 functools32==3.2.3-2 05:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:22 INFO - 'HOME': '/Users/cltbld', 05:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PAGER': '/bin/cat', 05:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - 'XPC_FLAGS': '0x0', 05:16:22 INFO - 'XPC_SERVICE_NAME': '0', 05:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:22 INFO - 'HOME': '/Users/cltbld', 05:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PAGER': '/bin/cat', 05:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - 'XPC_FLAGS': '0x0', 05:16:22 INFO - 'XPC_SERVICE_NAME': '0', 05:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:26 INFO - Downloading docopt-0.6.1.tar.gz 05:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:26 INFO - Running setup.py install for blobuploader 05:16:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:26 INFO - Running setup.py install for requests 05:16:27 INFO - Running setup.py install for docopt 05:16:27 INFO - Successfully installed blobuploader requests docopt 05:16:27 INFO - Cleaning up... 05:16:27 INFO - Return code: 0 05:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:27 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:27 INFO - 'HOME': '/Users/cltbld', 05:16:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:27 INFO - 'LOGNAME': 'cltbld', 05:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:27 INFO - 'MOZ_NO_REMOTE': '1', 05:16:27 INFO - 'NO_EM_RESTART': '1', 05:16:27 INFO - 'PAGER': '/bin/cat', 05:16:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:27 INFO - 'PWD': '/builds/slave/test', 05:16:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:27 INFO - 'SHELL': '/bin/bash', 05:16:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:27 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:27 INFO - 'USER': 'cltbld', 05:16:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:27 INFO - 'XPC_FLAGS': '0x0', 05:16:27 INFO - 'XPC_SERVICE_NAME': '0', 05:16:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-eTKrA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:27 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RzxZwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lhyrPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Sm6YgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zkz50F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Wbou_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-p7uYQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-EWhIw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6royWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-DxqNS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zeyF3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:28 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_oRkcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Xx2lE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MfLfCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-dYtgoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-4HtUap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:29 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-P_UDq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:29 INFO - Running setup.py install for manifestparser 05:16:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:29 INFO - Running setup.py install for mozcrash 05:16:29 INFO - Running setup.py install for mozdebug 05:16:30 INFO - Running setup.py install for mozdevice 05:16:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Running setup.py install for mozfile 05:16:30 INFO - Running setup.py install for mozhttpd 05:16:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Running setup.py install for mozinfo 05:16:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Running setup.py install for mozInstall 05:16:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:30 INFO - Running setup.py install for mozleak 05:16:30 INFO - Running setup.py install for mozlog 05:16:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Running setup.py install for moznetwork 05:16:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Running setup.py install for mozprocess 05:16:31 INFO - Running setup.py install for mozprofile 05:16:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Running setup.py install for mozrunner 05:16:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:31 INFO - Running setup.py install for mozscreenshot 05:16:31 INFO - Running setup.py install for moztest 05:16:31 INFO - Running setup.py install for mozversion 05:16:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:32 INFO - Cleaning up... 05:16:32 INFO - Return code: 0 05:16:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:32 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:32 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:32 INFO - 'HOME': '/Users/cltbld', 05:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:32 INFO - 'LOGNAME': 'cltbld', 05:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:32 INFO - 'MOZ_NO_REMOTE': '1', 05:16:32 INFO - 'NO_EM_RESTART': '1', 05:16:32 INFO - 'PAGER': '/bin/cat', 05:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:32 INFO - 'PWD': '/builds/slave/test', 05:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:32 INFO - 'SHELL': '/bin/bash', 05:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:32 INFO - 'USER': 'cltbld', 05:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:32 INFO - 'XPC_FLAGS': '0x0', 05:16:32 INFO - 'XPC_SERVICE_NAME': '0', 05:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-94106h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Ja11a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nLsYpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Nk2W1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-RfjvjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:32 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hrRpFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-A6zMOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ng_Rp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-oUUkYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LDUTbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Z9Je1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9sPSta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Y9W6yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-YJqOAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:33 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3ws0b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-317fWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2RywHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:16:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:37 INFO - Downloading blessings-1.6.tar.gz 05:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:37 INFO - Installing collected packages: blessings 05:16:37 INFO - Running setup.py install for blessings 05:16:37 INFO - Successfully installed blessings 05:16:37 INFO - Cleaning up... 05:16:37 INFO - Return code: 0 05:16:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:37 INFO - Reading from file tmpfile_stdout 05:16:37 INFO - Current package versions: 05:16:37 INFO - blessings == 1.6 05:16:37 INFO - blobuploader == 1.2.4 05:16:37 INFO - docopt == 0.6.1 05:16:37 INFO - functools32 == 3.2.3-2 05:16:37 INFO - jsonschema == 2.5.1 05:16:37 INFO - manifestparser == 1.1 05:16:37 INFO - mozInstall == 1.12 05:16:37 INFO - mozcrash == 0.17 05:16:37 INFO - mozdebug == 0.1 05:16:37 INFO - mozdevice == 0.48 05:16:37 INFO - mozfile == 1.2 05:16:37 INFO - mozhttpd == 0.7 05:16:37 INFO - mozinfo == 0.9 05:16:37 INFO - mozleak == 0.1 05:16:37 INFO - mozlog == 3.3 05:16:37 INFO - moznetwork == 0.27 05:16:37 INFO - mozprocess == 0.23 05:16:37 INFO - mozprofile == 0.28 05:16:37 INFO - mozrunner == 6.12 05:16:37 INFO - mozscreenshot == 0.1 05:16:37 INFO - mozsystemmonitor == 0.3 05:16:37 INFO - moztest == 0.7 05:16:37 INFO - mozversion == 1.4 05:16:37 INFO - psutil == 3.1.1 05:16:37 INFO - requests == 1.2.3 05:16:37 INFO - wsgiref == 0.1.2 05:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 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 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:38 INFO - 'HOME': '/Users/cltbld', 05:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:38 INFO - 'LOGNAME': 'cltbld', 05:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:38 INFO - 'MOZ_NO_REMOTE': '1', 05:16:38 INFO - 'NO_EM_RESTART': '1', 05:16:38 INFO - 'PAGER': '/bin/cat', 05:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:38 INFO - 'PWD': '/builds/slave/test', 05:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:38 INFO - 'SHELL': '/bin/bash', 05:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:38 INFO - 'USER': 'cltbld', 05:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:38 INFO - 'XPC_FLAGS': '0x0', 05:16:38 INFO - 'XPC_SERVICE_NAME': '0', 05:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:38 INFO - Cleaning up... 05:16:38 INFO - Return code: 0 05:16:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107572a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107607618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf18dc4620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, '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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:38 INFO - 'HOME': '/Users/cltbld', 05:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:38 INFO - 'LOGNAME': 'cltbld', 05:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:38 INFO - 'MOZ_NO_REMOTE': '1', 05:16:38 INFO - 'NO_EM_RESTART': '1', 05:16:38 INFO - 'PAGER': '/bin/cat', 05:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:38 INFO - 'PWD': '/builds/slave/test', 05:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:38 INFO - 'SHELL': '/bin/bash', 05:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:16:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:38 INFO - 'USER': 'cltbld', 05:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:38 INFO - 'XPC_FLAGS': '0x0', 05:16:38 INFO - 'XPC_SERVICE_NAME': '0', 05:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:38 INFO - Cleaning up... 05:16:38 INFO - Return code: 0 05:16:38 INFO - Running post-action listener: _resource_record_post_action 05:16:38 INFO - Running post-action listener: _start_resource_monitoring 05:16:38 INFO - Starting resource monitoring. 05:16:38 INFO - [mozharness: 2016-08-16 12:16:38.617671Z] Finished create-virtualenv step (success) 05:16:38 INFO - [mozharness: 2016-08-16 12:16:38.618606Z] Running install step. 05:16:38 INFO - Running pre-action listener: _resource_record_pre_action 05:16:38 INFO - Running main action method: install 05:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:38 INFO - Reading from file tmpfile_stdout 05:16:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:38 INFO - Reading from file tmpfile_stdout 05:16:38 INFO - Output received: 05:16:38 INFO - Usage: mozinstall [options] installer 05:16:38 INFO - Options: 05:16:38 INFO - -h, --help show this help message and exit 05:16:38 INFO - -d DEST, --destination=DEST 05:16:38 INFO - Directory to install application into. [default: 05:16:38 INFO - "/builds/slave/test"] 05:16:38 INFO - --app=APP Application being installed. [default: firefox] 05:16:38 INFO - mkdir: /builds/slave/test/build/application 05:16:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:13 INFO - Reading from file tmpfile_stdout 05:17:13 INFO - Output received: 05:17:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:13 INFO - Running post-action listener: _resource_record_post_action 05:17:13 INFO - [mozharness: 2016-08-16 12:17:13.228340Z] Finished install step (success) 05:17:13 INFO - [mozharness: 2016-08-16 12:17:13.228496Z] Running run-tests step. 05:17:13 INFO - Running pre-action listener: _resource_record_pre_action 05:17:13 INFO - Running main action method: run_tests 05:17:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:13 INFO - 2016-08-16 05:17:13.243 screenresolution[1638:7523] starting screenresolution argv=screenresolution get 05:17:13 INFO - 2016-08-16 05:17:13.245 screenresolution[1638:7523] Display 0: 1600x1200x32@60 05:17:13 INFO - 2016-08-16 05:17:13.251 screenresolution[1639:7525] starting screenresolution argv=screenresolution list 05:17:13 INFO - Available Modes on Display 0 05:17:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:13 INFO - Intel Iris: 05:17:13 INFO - Chipset Model: Intel Iris 05:17:13 INFO - Type: GPU 05:17:13 INFO - Bus: Built-In 05:17:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:13 INFO - Vendor: Intel (0x8086) 05:17:13 INFO - Device ID: 0x0a2e 05:17:13 INFO - Revision ID: 0x0009 05:17:13 INFO - Displays: 05:17:13 INFO - Display: 05:17:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:13 INFO - Display Serial Number: 1600x1200 60 05:17:13 INFO - Main Display: Yes 05:17:13 INFO - Mirror: Off 05:17:13 INFO - Online: Yes 05:17:13 INFO - Rotation: Supported 05:17:13 INFO - Return code: 0 05:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:13 INFO - Python 2.7.3 05:17:13 INFO - Return code: 0 05:17:13 INFO - grabbing minidump binary from tooltool 05:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d6d30>, '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 0x10723bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1074ceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:13 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 05:17:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:13 INFO - Return code: 0 05:17:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 05:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NRRA5Q0JEe/Render', 05:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:13 INFO - 'HOME': '/Users/cltbld', 05:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:13 INFO - 'LOGNAME': 'cltbld', 05:17:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:13 INFO - 'MOZ_NO_REMOTE': '1', 05:17:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:13 INFO - 'NO_EM_RESTART': '1', 05:17:13 INFO - 'PAGER': '/bin/cat', 05:17:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:13 INFO - 'PWD': '/builds/slave/test', 05:17:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:13 INFO - 'SHELL': '/bin/bash', 05:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jk8qHWgfMq/Listeners', 05:17:13 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:13 INFO - 'USER': 'cltbld', 05:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:13 INFO - 'XPC_FLAGS': '0x0', 05:17:13 INFO - 'XPC_SERVICE_NAME': '0', 05:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:17:13 INFO - mozversion application_buildid: 20160816031824 05:17:13 INFO - mozversion application_changeset: bc160abe215baed95384cb10e17118b168caa05a 05:17:13 INFO - mozversion application_display_name: Nightly 05:17:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:13 INFO - mozversion application_name: Firefox 05:17:13 INFO - mozversion application_remotingname: firefox 05:17:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:13 INFO - mozversion application_vendor: Mozilla 05:17:13 INFO - mozversion application_version: 51.0a1 05:17:13 INFO - mozversion platform_buildid: 20160816031824 05:17:13 INFO - mozversion platform_changeset: bc160abe215baed95384cb10e17118b168caa05a 05:17:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:13 INFO - mozversion platform_version: 51.0a1 05:17:13 INFO - using testdate: 1471349833 05:17:13 INFO - actual date: 1471349833 05:17:13 INFO - starting webserver on 'localhost:49269' 05:17:13 INFO - SUITE-START | Running 2 tests 05:17:13 INFO - TEST-START | dromaeo_css 05:17:13 INFO - operating with platform_type : mac_ 05:17:13 INFO - Initialising browser for dromaeo_css test... 05:17:13 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpBn6nnA/profile http://localhost:49269/getInfo.html) 05:17:17 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 05:17:17 INFO - PROCESS | 1649 | colorDepth:24 05:17:17 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 05:17:17 INFO - PROCESS | 1649 | __metrics 05:17:17 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:17:18 INFO - TEST-INFO | 1649: exit 0 05:17:18 INFO - Browser initialized. 05:17:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:18 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpBn6nnA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:30 INFO - PROCESS | 1656 | RSS: Main: 239132672 05:17:30 INFO - PROCESS | 1656 | 05:18:19 INFO - PROCESS | 1656 | 1471349899694 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:20:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 05:20:33 INFO - PROCESS | 1656 | RSS: Main: 253980672 05:20:33 INFO - PROCESS | 1656 | 05:23:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 05:23:36 INFO - PROCESS | 1656 | RSS: Main: 264978432 05:23:36 INFO - PROCESS | 1656 | 05:26:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 05:26:39 INFO - PROCESS | 1656 | RSS: Main: 271278080 05:26:39 INFO - PROCESS | 1656 | 05:29:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 05:29:41 INFO - PROCESS | 1656 | RSS: Main: 270618624 05:29:41 INFO - PROCESS | 1656 | 05:32:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 05:32:45 INFO - PROCESS | 1656 | RSS: Main: 276066304 05:32:45 INFO - PROCESS | 1656 | 05:35:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 05:35:48 INFO - PROCESS | 1656 | RSS: Main: 278720512 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | __start_tp_report 05:35:48 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 05:35:48 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 05:35:48 INFO - PROCESS | 1656 | |i|pagename|runs| 05:35:48 INFO - PROCESS | 1656 | |0;dojo.html;3411.607665118512;3414.3854106260874;3448.6378930212327;3466.445368741002;3478.5130081788548;4804;5692.629979051364;5719.542436605072;5720.1991721159075;5764.365919748835;4894.608431325494;5327.493888080636;5680.233168522248;5794.478496935286;5823.505002074829;5060.367454068241;5237.685738855662;5253.369595648527;5282.366116066078;5307.442718514559;4400.031992961543;5338.252644629735;5353.9196912046355;5405.621606487547;5410.56715462764;5130.333056702642;5170.870728231786;5302.098643230622;5313.282706834567;5318.46815318467;4784.234522476422;5190.455002224788;5214.661047031968;5216.66091704038;5280.155175171954;5185.196294574347;5195.480451954812;5195.792168313263;5261.76322065508;5322.0952438085615;5560.415281644712;5668.43315668434;5698.088305871041;5800.390958949291;5817.505512031483;6176.413240742122;6179.104029915637;6235.376462353774;6242.094896240065;6256.061590761422;5429.267048948381;5550.86122846928;6201.751929922798;6208.689565521706;6215.1609532712955;4664.300354946785;4812.278158276216;5010.849674509771;5758.165066065397;5805.01314776489;6338.461230795342;6342.4926005919415;6346.746130154742;6347.52393570484;6359.427651511386;6164.4143806338325;6169.629822210682;6199.3490683478485;6201.007838745779;6210.130581718563;6135.386461353918;6143.358355907003;6170.969145154246;6178.474829639441;6207.379262073757;5063.898722025612;6157.138000679908;6187.257529096537;6192.071189321638;6250.624962502265;5696.8006119785605;6204.906926396107;6261.968690156611;6279.120923070774;6281.120643109877;4877.365942427462;4929.704217746947;4935.679180853305;4945.604351651859;4952.479989601112;4377.409049778303;4431.158079964861;4435.6895017349125;4443.955560444419;4501.504834468205;5764.394738552475;5841.88316233673;5861.20873682056;5868.941310586925;5872.618279811799;4965.90068198634;6227.906581401192;6235.906461403082;6251.3123556408755;6262.655553944577;5814.418558144236;5850.502707269845;5854.7072646367515;5858.121281807763;5875.794347197828;5458.972705136449;5466.34403871538;5471.398146203915;5485.259489968883;5500.972495137498;6175.2898416681755;6284.968575157095;6295.244570651551;6332.683365831598;6381.521385895983;6278.811635650938;6287.434130928238;6293.811185664437;6295;6299.779507717391;6286.119943207863;6366.236051673829;6373.968130159319;6387.361263873576;6410.358964103552;6086.087086936995;6154.538409619386;6164.568480206342;6181.5363847710705;6224.595401298901;6301.905471417841;6313.842153946004;6321.557490975588;6324.620522768465;6336.112944187726;6175.475084617858;6185.381461853779;6195.81412557624;6202.28673702512;6223.564350495421;6004.729787159501;6032.426919442646;6114.510272098727;6120.938790612215;6173.969130154321;5842.766289348378;5850.970745146247;6056.182415373868;6059.33347331802;6112.1748563945075;6141.109539116714;6156.076588511759;6183.350748171377;6187.938120618736;6196.783112591038;5857.26784151981;5936.050231962865;5975.940240597538;6070.2412198475195;6071.180390647382 05:35:48 INFO - PROCESS | 1656 | |1;ext.html;521.9112750832359;524.1063985904032;525.1204232909877;538.5395486858736;540.1411755309058;30549.84725076374;41365.58634413655;41411.58588414119;41451.963700907494;41477.37783933243;42001.57998420015;42460.363094553526;42514.36228456576;42595.36106958398;42653;9786.65746698864;9952.303338766289;9963.950180249089;9981.901990781045;9997.15024222942;9774.462404567746;9868.210543156567;9899.109080182781;9903.563983222428;9925.106740393363;8304.377171712116;8747.650093996264;8879.600417981206;9437.386569872971;9918.752031199241;8394.622241999125;9754.756131096708;9793.020697930222;9853;9871.309008369417;9693.515324233831;9736.659216927374;9756.951215243878;9762.219022478184;9801.607935682565;38594;40347;40434;40774;40943.38584921229;2650.4301575161435;3273.1980664737052;3321.335732853439;3501.2647344057777;3510.666486683761;30281.848590757127;30886.691133088607;30979.380412391853;31931.201719957186;32031.839840800647;2582.5093232285803;3143.2613335866054;3147.213196700825;3149.9055028349185;3165.0346644273486;411411;413746;415625;415986;417365.91317043523;33764;33908.830455847565;33924.42020327273;33988.49017264743;34008.149796254795;33638.32723345568;34046;34178.14554636104;34666.48000279998;35438;15202;15369.846301536842;15391.999520031162;15396;15453.5363939082;11596.130290228266;11727.824082638766;11738.002269806992;11752.177347585586;11770.940615344489;15615.375384984472;19152.138153783115;19200.231990720495;19206.519837004187;19245.326413575458;7279.490435669558;8018.879716804253;8046.275835174863;8132.796680083045;8201.95899020513;756.7994481462417;900.2482926756232;940.1150692860907;1018.6842078955548;1090.96903426263;28066.2983425416;29716;30911;31315.686843131276;31850.26695194887;993.1657407777501;1020.8111499372492;1052.8210204265292;1057.5981127171626;1129.1869853705318;16039.679206415807;16197.83802161987;16208.51374458768;16230.756538651929;16610.418635347945;636320;641278;642302;643492.5650743527;645011;50775.73060673439;59114.40885591175;59648;60313.69843150756;60320.39679603236;1348.1776116568885;1371.739369519788;1391.7355702416507;1391.9768969807183;1394.0868730981224;29449.263768405963;31032.68967310298;32005.839970799996;32538;32570;57202.7139864298;58106;58133.83732325414;58271.4172858283;58337.70831145987;625344;628011;630926;630989;631260;44235.55764442314;44539.55460445484;45034;45113.32330014987;45118;49066.75466622787;49314.50685493243;49841;50630.24054639257;50775.2383714252;34029.65970340364;39927;40192;41298;41321.380179297936;33156.00531984044;38440.423393649675;39398.04514661354;41325.586744132175;41332.58667413408;30031.84984075153;38544.03639909025;39219.607803922736;39544.60455395524;39943.80028099841;34356.82821585976;35012;35826.820865895505;35906.82046589855;36185.27629447449;21375.931203439453;22844;24467.43091975317;25188.874055629603;25936 05:35:48 INFO - PROCESS | 1656 | |2;jquery.html;344.71216534193945;354.6205560050744;370.8794641741435;372.8415423445035;398.0446927374301;20098.296559620416;20116.295929642467;20585.38243852683;21172.57654846902;21450.927453627333;19176.712349314737;19371.128299226533;19671.606567868635;19680.212791488324;20045.498862528446;5399.9730001350035;5465.426130256325;5571.693556854371;5576.804811831586;5925.525957923356;6090.66501342426;6220.688965551727;6230.8442288942915;6251.12484252205;6263;6233.594816336947;6239.469645080174;6305.810825675214;6912.619805910673;6958.826029349256;6396.456301214403;6915.481338899603;6917;6974.546654467444;6985.301469853;6055.212822333068;6132.662703551303;6132.7240274187325;6135.938640613582;6148.569600127993;13547.45810167592;13621.978351623668;13776.24230667313;13813.102148360324;13964.022518423715;2157.7194964654495;2183.1049269799464;2289.5077558324874;2556;2647.377866201441;9870.309078364517;10530.684079477627;10686.839697404544;11421.343905133708;13070.803937940938;1724.5257554172576;1912.4071537823181;1920.5102698811854;1965.8329042031444;1987.7217189593468;115307;122372;125240.37379813133;126485.47029059367;127892.36053819764;9290;10767.946160269148;11253.81834907323;11513.654590362303;11754.764904701859;12008;14046.367913443919;14380.712385752226;14467.855321446861;14504.927475362556;7962.601869906482;8179.713710020121;8209.95895020533;8334.791630209293;8356.080831108573;7914.643841027168;7992.960035199903;7999.480033797785;8120.106788253287;8160.795980100545;3583.8566457341412;3955.7626542407547;4419.558044195554;4547.909041819145;4580.129775342674;1934.6204168872084;1976.1403789351677;1986.692062730279;2012.4465771912842;2023.6357455657828;850.1753299299669;870.9216170544555;888.7379920512888;1003.5433877585681;1059.692689120162;20304.69542956857;21177.470563236042;21885.67171492429;21917;22209.777902220772;754.5359603843706;777.5995362388375;913.2648218184293;945.6926498887889;1005.9144972677258;10110.69667909964;10576.788464230673;11131.109511239081;11671.183017188885;11683.883161168449;562184;563192.1840390771;574541;582895;625376;75690;130057.69942300455;130161;134992.32503837417;146387;965.7778710896533;1006.5621454667244;1039.428314427062;1041.0578426524007;1043.3791893823163;17859.553511162325;19717.507062323555;19769.11039003277;19951.60096798027;20228.08973596221;57309;57759.71120144372;57783;58199.83600327885;58425;73865;76973;79199.20800791918;81415.18584814075;86489;7655.928170056085;7785.260400261966;7918.970533830565;8183.754487365389;8239.711610093618;9470.384425012353;11085.390303533382;13348.265845378597;13842.307884605529;13874.167549947035;11382.886171138183;11534.942325288655;11685.532578697097;11749.236299640495;11783.646490605295;10402.375857448576;10518.474076296308;11443.599474018702;11528.481218345363;11853.822192666945;11345;11424.771504570028;11616.94191529037;11727.413629318671;12112.636620901387;8137.186281371815;8143.18568143181;8420.242178203991;8505.87241191395;8595.871061934202;9428.245740340893;9881.85177222328;11013.953674400918;11584.247023943417;11717.76564468723 05:35:48 INFO - PROCESS | 1656 | |3;mootools.html;1483.9035462694922;1523.8247601525825;1709.6751617192733;1806.3226290141197;1858.2845604442293;7606.733764318236;8174.2234487723645;8256.091829898707;8643.178898004688;8648.437851539662;8324.50052996819;8471.237588617023;8480.067192608809;8492.787680307996;8493.49039057657;1954.7263383126374;2268.7731226877263;2304.539092181562;2306.08909480755;2309.607366747657;1768.9203985820604;1814.28335807356;2016.737824082867;2166.8916554172306;2315.81473482121;2261.9660705089436;2284.497410569672;2285.897134628946;2295.9897645036212;2322.1872344679396;2268.2288022072494;2281.3498153026308;2291.6562515622622;2299.494111295512;2302.1597117052324;2278.225403362848;2281.6349384098467;2284.0521183708743;2287.0508738873345;2295.5753185660537;7177.89233161503;8516.957415212946;8522.232999030117;8643.913560864374;8658.177473140042;4928.778204980785;5061.949380506185;5088.694678319275;5092.949070509321;5094.2103973884105;3337.2324365396094;3409.3522230776075;3494.9864539283576;3534.68187863091;3545.149164200573;1057.2070946789909;1064.6486659402378;1065.7868426314767;1067.9572817087308;1085.4952447112053;10918.1811364148;10941.83587246192;11040.558377664884;11054.115670746321;11071.391073490955;4433.82264709408;4533.84131555394;4562.84030058953;4688.296755486705;4689.601383882408;9266.166045055978;9352.251819854395;9361.110694484014;9364.391314564531;9366.203872670763;4980.5019498049905;5035.647504674711;5037.823676171316;5089.312942752681;5093.312402825645;4230.598093181143;4555.088982203572;4705.741184234831;4724.574788269072;4733.715977041388;3800.277947190025;3818.3581060144406;3884.708646851441;3909.8240579174008;3913.8238779255003;1265.221888538542;1272.5164437513686;1277.2272774971195;1277.6039427777418;1283.9037072219621;755;851.8679604661287;894.8926128864578;898.8382091223511;909.4452384045727;4647.837325693652;5834.708264586754;5889.617174883619;5891.646501209942;5898;867.9783005424789;879.2087121590491;902.4495058014605;941.087145468894;1040.4860927350687;3780.8865734028022;3798.7910664913143;3814.599467055975;3987.043109653662;3989.880303590897;10002.349847259904;10206.234532410099;10250.58997640101;10257.58969641221;10273.229507786946;9467.621295148117;9961.35251208669;10220.02909723575;10226.13077888373;10303.74240643975;7827.804304892423;7991.760247192594;8008.439409241414;8028.558429286329;8029.4379393441895;5074.847754567369;5409.053415652324;5610.85972850682;5873.119032145212;5960.612560183574;9195.632174713204;9624.51877406141;9738.513074346396;9742.269329800152;9747.610095596097;9442.433453992782;9766.316357854881;9776.706698799047;9907.306488545733;9917.206623470249;5197.4282828889545;5827.329857066492;6857.108575885103;7206.135263768172;7303.926960730325;8153.673853046049;8221.958890205511;8223.506589604644;8227.629756660845;8262.83474330522;7256.129264488295;7349.007883935814;7410.333070023724;7421.480496365202;7507.587082710504;6214.40963108504;7189.712411503481;7267.236940121211;7268.96365518169;7311.926880731125;6610.338966103352;6712.395884370235;6773.491988101011;6784.966075169593;6785.287544807921;4738.478767335521;4804.183288840835;4814.542618451242;4861.829835955725;4906.09237291088;4732.432108147044;4755.215389460838;4853.247746599282;4904.068227036852;5024.296598476143 05:35:48 INFO - PROCESS | 1656 | |4;prototype.html;293.22442140538266;298.8938926681028;305.32370798680915;307.19974466514714;311.14125014958705;4865.9781445896315;4890.926636100461;4902.583280421169;5261.76322065507;5651.858703532409;4117.135401565667;5613.915791263124;5649.107548971099;5666.603337766348;5667.206591077253;3735.495708079415;3782.262458820517;4322.935155972663;4331.960329520924;4345.69580129391;3979.900502487432;3999.060220848098;4227.344761561947;4300.827966881321;4364.650827933758;3460.757746957714;3483.7909725416557;4211.68412369072;4221.683373746966;4277.850275240367;3402.7788193767324;4181.808184667386;4214.473190851144;4218.641415479658;4229.471316085504;3637.854485820564;3646.5441819772527;3657.5428071491065;3660.3411385950517;3675.8345874435713;4346.913061738747;5371.704556249405;5426.375966763833;5445.156000819839;5531;4263.658907287409;4600.769961501945;4777.737224452654;4780.880477988043;4880.292357608127;5034.320366750479;5159.871003224912;5906.645601263938;5933.664925391796;6007.61824780303;3497.807620580867;3723.4973278607313;3936.8937618374034;3942.7437216581116;3949.8420063197723;6089.665068421235;6116.602420842631;6321.273053598849;6394.168758061469;6425.357464253584;3514.578250609892;3541.4333706606817;3941.9802900985887;3969.947963789598;4049.493813273341;3679.981600092036;3719.9584116447436;3803.4294855771304;4126.7523948563185;4134.4005119258145;4826.517348265145;4828.5412885775795;4858.222684370484;4870.951290487121;4879.413630981297;4985.277134815431;5282.445343238905;5293.814716484904;6031.220789866999;6149.446549810449;1324.0136098606408;1329.3751936589788;1373.169232614274;1384.806127142201;1406.8955869642487;801.7755028592004;889.9765269939621;921.1755478846395;939.3565407695751;946.7538440005649;4817.855464336076;5613.8596535086135;5660.632058916157;5667.943320566742;5710.5146062585145;5917.615355001911;6167.506599472032;6192.792405480888;6262.248530176317;6285.528585356116;5313.707746074003;5551.472610102034;5616.977887960331;5648.717564121777;5681.289838770153;2634.89460421581;2741.5606806426786;2760.4341110072387;2793.846338451405;2798.5522316429274;4315.136972605492;4654.627629789608;5089.083964886282;5390.385662953543;5415.729213539307;4980.028894365636;5884.558658100659;6108.877822443526;6420.422162005442;6537.607743535403;6555.606663600009;6557.278699343068;6588.8023359299295;6589.47284217271;6594.868102638016;5833.191710569737;6032.1856549365275;6274.843128921813;6396.0405939109505;6396.680165991589;5110.61670374716;6019.668918209541;6240.875182496416;6244.2819075806865;6257.937420625917;5563.554915606823;6583.967080164569;6604.702788374439;6611.371919667624;6646.136002319668;3555.9687690569444;3650.8904732858055;3974.4634474345594;4090.570490098497;4117.958820411877;5983.311919129182;6296.677697683354;6305.563467910092;6330.588511746721;6374.553781235269;4936.605071594336;5422.457754224546;5767.9134812977;6049.485793707584;6072.72672729737;4800.423949126127;6057.848553786191;6070.423309785563;6087.117367981707;6134.539909506894;4635.6986795858165;5748.798792042258;5883.823485295276;5929.7547515022325;6036.426539478743;5909.468147866541;6008.369121242206;6014.1957412776865;6051.364606716232;6067.362926892612;4499.662525310549;5208.348956380452;5973.372795856372;5993.460588547052;6010.098485227076 05:35:48 INFO - PROCESS | 1656 | |5;yui.html;668.3183153183753;710.1159056974068;714.8954864733986;715.706560310273;728.497336837582;12922.353882305883;15085.396584136648;15525.611859703513;15701.528954131394;15709.057456552615;14462.783058254134;14478.782818257734;14580.270986450689;14581.489647862327;14601;675.5845155229523;840.7645859159445;860.4837097741367;864.0840708848641;866.0300463480879;832.2883934236231;848.6266042941086;859.0893652728097;866.6923242249005;868.5309932636369;900.8288425199224;903.0337538833451;903.588867065487;904.4482865452069;909.2862103248951;863.8488264553678;894.789724414762;895.6909866096187;895.8880139982502;897.3583887520422;657.3557913244999;661.6625520984285;665.3845193196322;666.7632990288474;668.4184759259475;14813.629659258497;15012.174330411823;15021.399144034225;15042.849571504254;15050.172240526766;14572.781408278885;14651;14858.405663773436;14994.70010599782;15032.849671503363;11996.340201288926;12062.336571488564;12192.207506512137;12390.31853248071;12411.379431028503;3862.1310205203886;3894.7663140211394;3996.7402118862474;4068.2677118118727;4132.979335103335;106616.46691766569;108661;108823;109734;109919;10873.782524349468;11279.266847654877;11336.991706695571;11416.771664566828;11825.349605771766;23451.530969380517;23495.41261468477;23507.17724879621;23553.175638852557;23575.646365304536;7594;7698.96150519255;8146.266835984789;8307.335413166933;8431.873521897176;4457.554244575581;4539.84110556129;4549.294859296814;4560.315952607069;4564.2240819060835;3417.743669224818;3532.3111993161087;3545.149164200573;3559.199180184438;3563.768355056913;534.0760484361998;546.5955193157035;605.857623458487;620.3021600699213;623.2240860129168;452.07324983783116;514.6963291657939;514.7080827123946;625.0811307378146;628.5129025005566;8592.8711069334;8641.956790216134;8648.740537783751;9773.364731292444;10085.445300508396;466.5031741195616;517.8938317644873;584.8917950179231;613.5735663713676;657.572577824418;3850.5764365919727;3890.9416358754643;4520.50274469808;4668.85993420198;4722.811087556528;141657.29171354076;144306;153231.23384383006;153643;154219;120311;124895;130863.34568327098;131213;131638.34180829034;94643;112162;114105.42947285376;118190;118380;8739.431936924333;9022.278217742434;9074.228690561376;9128.406653567497;9176;46520;47786;58127.418725812204;60330.396696032476;63274.050889235776;76811.61594191994;80243.79634305373;88708;94406.52796735973;95964.52017739866;12035.819462708241;12094.637160885188;12155.513779448724;13066.738665226452;13212.207267563977;14729.55811325662;15228.923855380652;15451.381944722534;15575;15600.92199538995;13929.094608850392;14133.505327313906;14167.64580885445;14676.55970320892;14981.550553483414;14216.57350279452;14363.497277595234;14419.78370324425;14537.200453975132;14639.194844283667;13705.794413084011;14034.859651403764;14182.503612373517;14495.347709352893;14648.926755366156;11143.72140696489;11373.14701397382;11521.308721476738;11624.76750464969;11933.52265909354;9771.413715177112;10159.115681131672;11554.826677599674;11670.824937625772;11700.414979250832 05:35:48 INFO - PROCESS | 1656 | __end_tp_report 05:35:48 INFO - PROCESS | 1656 | __start_cc_report 05:35:48 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,411 05:35:48 INFO - PROCESS | 1656 | __end_cc_report 05:35:48 INFO - PROCESS | 1656 | __startTimestamp1471350948174__endTimestamp 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | ------- Summary: start ------- 05:35:48 INFO - PROCESS | 1656 | Number of tests: 6 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5720.34 Median:5875.79 stddev:661.44 (11.3%) stddev-sans-first:638.19 05:35:48 INFO - PROCESS | 1656 | Values: 3411.6 3414.4 3448.6 3466.4 3478.5 4804.0 5692.6 5719.5 5720.2 5764.4 4894.6 5327.5 5680.2 5794.5 5823.5 5060.4 5237.7 5253.4 5282.4 5307.4 4400.0 5338.3 5353.9 5405.6 5410.6 5130.3 5170.9 5302.1 5313.3 5318.5 4784.2 5190.5 5214.7 5216.7 5280.2 5185.2 5195.5 5195.8 5261.8 5322.1 5560.4 5668.4 5698.1 5800.4 5817.5 6176.4 6179.1 6235.4 6242.1 6256.1 5429.3 5550.9 6201.8 6208.7 6215.2 4664.3 4812.3 5010.8 5758.2 5805.0 6338.5 6342.5 6346.7 6347.5 6359.4 6164.4 6169.6 6199.3 6201.0 6210.1 6135.4 6143.4 6171.0 6178.5 6207.4 5063.9 6157.1 6187.3 6192.1 6250.6 5696.8 6204.9 6262.0 6279.1 6281.1 4877.4 4929.7 4935.7 4945.6 4952.5 4377.4 4431.2 4435.7 4444.0 4501.5 5764.4 5841.9 5861.2 5868.9 5872.6 4965.9 6227.9 6235.9 6251.3 6262.7 5814.4 5850.5 5854.7 5858.1 5875.8 5459.0 5466.3 5471.4 5485.3 5501.0 6175.3 6285.0 6295.2 6332.7 6381.5 6278.8 6287.4 6293.8 6295.0 6299.8 6286.1 6366.2 6374.0 6387.4 6410.4 6086.1 6154.5 6164.6 6181.5 6224.6 6301.9 6313.8 6321.6 6324.6 6336.1 6175.5 6185.4 6195.8 6202.3 6223.6 6004.7 6032.4 6114.5 6120.9 6174.0 5842.8 5851.0 6056.2 6059.3 6112.2 6141.1 6156.1 6183.4 6187.9 6196.8 5857.3 5936.1 5975.9 6070.2 6071.2 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68972.00 Median:40604.00 stddev:152989.61 (376.8%) stddev-sans-first:153332.46 05:35:48 INFO - PROCESS | 1656 | Values: 521.9 524.1 525.1 538.5 540.1 30549.8 41365.6 41411.6 41452.0 41477.4 42001.6 42460.4 42514.4 42595.4 42653.0 9786.7 9952.3 9964.0 9981.9 9997.2 9774.5 9868.2 9899.1 9903.6 9925.1 8304.4 8747.7 8879.6 9437.4 9918.8 8394.6 9754.8 9793.0 9853.0 9871.3 9693.5 9736.7 9757.0 9762.2 9801.6 38594.0 40347.0 40434.0 40774.0 40943.4 2650.4 3273.2 3321.3 3501.3 3510.7 30281.8 30886.7 30979.4 31931.2 32031.8 2582.5 3143.3 3147.2 3149.9 3165.0 411411.0 413746.0 415625.0 415986.0 417365.9 33764.0 33908.8 33924.4 33988.5 34008.1 33638.3 34046.0 34178.1 34666.5 35438.0 15202.0 15369.8 15392.0 15396.0 15453.5 11596.1 11727.8 11738.0 11752.2 11770.9 15615.4 19152.1 19200.2 19206.5 19245.3 7279.5 8018.9 8046.3 8132.8 8202.0 756.8 900.2 940.1 1018.7 1091.0 28066.3 29716.0 30911.0 31315.7 31850.3 993.2 1020.8 1052.8 1057.6 1129.2 16039.7 16197.8 16208.5 16230.8 16610.4 636320.0 641278.0 642302.0 643492.6 645011.0 50775.7 59114.4 59648.0 60313.7 60320.4 1348.2 1371.7 1391.7 1392.0 1394.1 29449.3 31032.7 32005.8 32538.0 32570.0 57202.7 58106.0 58133.8 58271.4 58337.7 625344.0 628011.0 630926.0 630989.0 631260.0 44235.6 44539.6 45034.0 45113.3 45118.0 49066.8 49314.5 49841.0 50630.2 50775.2 34029.7 39927.0 40192.0 41298.0 41321.4 33156.0 38440.4 39398.0 41325.6 41332.6 30031.8 38544.0 39219.6 39544.6 39943.8 34356.8 35012.0 35826.8 35906.8 36185.3 21375.9 22844.0 24467.4 25188.9 25936.0 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34527.95 Median:21901.34 stddev:97496.96 (445.2%) stddev-sans-first:97736.68 05:35:48 INFO - PROCESS | 1656 | Values: 344.7 354.6 370.9 372.8 398.0 20098.3 20116.3 20585.4 21172.6 21450.9 19176.7 19371.1 19671.6 19680.2 20045.5 5400.0 5465.4 5571.7 5576.8 5925.5 6090.7 6220.7 6230.8 6251.1 6263.0 6233.6 6239.5 6305.8 6912.6 6958.8 6396.5 6915.5 6917.0 6974.5 6985.3 6055.2 6132.7 6132.7 6135.9 6148.6 13547.5 13622.0 13776.2 13813.1 13964.0 2157.7 2183.1 2289.5 2556.0 2647.4 9870.3 10530.7 10686.8 11421.3 13070.8 1724.5 1912.4 1920.5 1965.8 1987.7 115307.0 122372.0 125240.4 126485.5 127892.4 9290.0 10767.9 11253.8 11513.7 11754.8 12008.0 14046.4 14380.7 14467.9 14504.9 7962.6 8179.7 8210.0 8334.8 8356.1 7914.6 7993.0 7999.5 8120.1 8160.8 3583.9 3955.8 4419.6 4547.9 4580.1 1934.6 1976.1 1986.7 2012.4 2023.6 850.2 870.9 888.7 1003.5 1059.7 20304.7 21177.5 21885.7 21917.0 22209.8 754.5 777.6 913.3 945.7 1005.9 10110.7 10576.8 11131.1 11671.2 11683.9 562184.0 563192.2 574541.0 582895.0 625376.0 75690.0 130057.7 130161.0 134992.3 146387.0 965.8 1006.6 1039.4 1041.1 1043.4 17859.6 19717.5 19769.1 19951.6 20228.1 57309.0 57759.7 57783.0 58199.8 58425.0 73865.0 76973.0 79199.2 81415.2 86489.0 7655.9 7785.3 7919.0 8183.8 8239.7 9470.4 11085.4 13348.3 13842.3 13874.2 11382.9 11534.9 11685.5 11749.2 11783.6 10402.4 10518.5 11443.6 11528.5 11853.8 11345.0 11424.8 11616.9 11727.4 12112.6 8137.2 8143.2 8420.2 8505.9 8595.9 9428.2 9881.9 11014.0 11584.2 11717.8 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5475.32 Median:5002.40 stddev:3044.18 (60.9%) stddev-sans-first:3037.94 05:35:48 INFO - PROCESS | 1656 | Values: 1483.9 1523.8 1709.7 1806.3 1858.3 7606.7 8174.2 8256.1 8643.2 8648.4 8324.5 8471.2 8480.1 8492.8 8493.5 1954.7 2268.8 2304.5 2306.1 2309.6 1768.9 1814.3 2016.7 2166.9 2315.8 2262.0 2284.5 2285.9 2296.0 2322.2 2268.2 2281.3 2291.7 2299.5 2302.2 2278.2 2281.6 2284.1 2287.1 2295.6 7177.9 8517.0 8522.2 8643.9 8658.2 4928.8 5061.9 5088.7 5092.9 5094.2 3337.2 3409.4 3495.0 3534.7 3545.1 1057.2 1064.6 1065.8 1068.0 1085.5 10918.2 10941.8 11040.6 11054.1 11071.4 4433.8 4533.8 4562.8 4688.3 4689.6 9266.2 9352.3 9361.1 9364.4 9366.2 4980.5 5035.6 5037.8 5089.3 5093.3 4230.6 4555.1 4705.7 4724.6 4733.7 3800.3 3818.4 3884.7 3909.8 3913.8 1265.2 1272.5 1277.2 1277.6 1283.9 755.0 851.9 894.9 898.8 909.4 4647.8 5834.7 5889.6 5891.6 5898.0 868.0 879.2 902.4 941.1 1040.5 3780.9 3798.8 3814.6 3987.0 3989.9 10002.3 10206.2 10250.6 10257.6 10273.2 9467.6 9961.4 10220.0 10226.1 10303.7 7827.8 7991.8 8008.4 8028.6 8029.4 5074.8 5409.1 5610.9 5873.1 5960.6 9195.6 9624.5 9738.5 9742.3 9747.6 9442.4 9766.3 9776.7 9907.3 9917.2 5197.4 5827.3 6857.1 7206.1 7303.9 8153.7 8222.0 8223.5 8227.6 8262.8 7256.1 7349.0 7410.3 7421.5 7507.6 6214.4 7189.7 7267.2 7269.0 7311.9 6610.3 6712.4 6773.5 6785.0 6785.3 4738.5 4804.2 4814.5 4861.8 4906.1 4732.4 4755.2 4853.2 4904.1 5024.3 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4763.50 Median:5288.13 stddev:1553.20 (29.4%) stddev-sans-first:1520.89 05:35:48 INFO - PROCESS | 1656 | Values: 293.2 298.9 305.3 307.2 311.1 4866.0 4890.9 4902.6 5261.8 5651.9 4117.1 5613.9 5649.1 5666.6 5667.2 3735.5 3782.3 4322.9 4332.0 4345.7 3979.9 3999.1 4227.3 4300.8 4364.7 3460.8 3483.8 4211.7 4221.7 4277.9 3402.8 4181.8 4214.5 4218.6 4229.5 3637.9 3646.5 3657.5 3660.3 3675.8 4346.9 5371.7 5426.4 5445.2 5531.0 4263.7 4600.8 4777.7 4780.9 4880.3 5034.3 5159.9 5906.6 5933.7 6007.6 3497.8 3723.5 3936.9 3942.7 3949.8 6089.7 6116.6 6321.3 6394.2 6425.4 3514.6 3541.4 3942.0 3969.9 4049.5 3680.0 3720.0 3803.4 4126.8 4134.4 4826.5 4828.5 4858.2 4871.0 4879.4 4985.3 5282.4 5293.8 6031.2 6149.4 1324.0 1329.4 1373.2 1384.8 1406.9 801.8 890.0 921.2 939.4 946.8 4817.9 5613.9 5660.6 5667.9 5710.5 5917.6 6167.5 6192.8 6262.2 6285.5 5313.7 5551.5 5617.0 5648.7 5681.3 2634.9 2741.6 2760.4 2793.8 2798.6 4315.1 4654.6 5089.1 5390.4 5415.7 4980.0 5884.6 6108.9 6420.4 6537.6 6555.6 6557.3 6588.8 6589.5 6594.9 5833.2 6032.2 6274.8 6396.0 6396.7 5110.6 6019.7 6240.9 6244.3 6257.9 5563.6 6584.0 6604.7 6611.4 6646.1 3556.0 3650.9 3974.5 4090.6 4118.0 5983.3 6296.7 6305.6 6330.6 6374.6 4936.6 5422.5 5767.9 6049.5 6072.7 4800.4 6057.8 6070.4 6087.1 6134.5 4635.7 5748.8 5883.8 5929.8 6036.4 5909.5 6008.4 6014.2 6051.4 6067.4 4499.7 5208.3 5973.4 5993.5 6010.1 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24688.10 Median:3538.73 stddev:39243.34 (1109.0%) stddev-sans-first:39311.99 05:35:48 INFO - PROCESS | 1656 | Values: 668.3 710.1 714.9 715.7 728.5 12922.4 15085.4 15525.6 15701.5 15709.1 14462.8 14478.8 14580.3 14581.5 14601.0 675.6 840.8 860.5 864.1 866.0 832.3 848.6 859.1 866.7 868.5 900.8 903.0 903.6 904.4 909.3 863.8 894.8 895.7 895.9 897.4 657.4 661.7 665.4 666.8 668.4 14813.6 15012.2 15021.4 15042.8 15050.2 14572.8 14651.0 14858.4 14994.7 15032.8 11996.3 12062.3 12192.2 12390.3 12411.4 3862.1 3894.8 3996.7 4068.3 4133.0 106616.5 108661.0 108823.0 109734.0 109919.0 10873.8 11279.3 11337.0 11416.8 11825.3 23451.5 23495.4 23507.2 23553.2 23575.6 7594.0 7699.0 8146.3 8307.3 8431.9 4457.6 4539.8 4549.3 4560.3 4564.2 3417.7 3532.3 3545.1 3559.2 3563.8 534.1 546.6 605.9 620.3 623.2 452.1 514.7 514.7 625.1 628.5 8592.9 8642.0 8648.7 9773.4 10085.4 466.5 517.9 584.9 613.6 657.6 3850.6 3890.9 4520.5 4668.9 4722.8 141657.3 144306.0 153231.2 153643.0 154219.0 120311.0 124895.0 130863.3 131213.0 131638.3 94643.0 112162.0 114105.4 118190.0 118380.0 8739.4 9022.3 9074.2 9128.4 9176.0 46520.0 47786.0 58127.4 60330.4 63274.1 76811.6 80243.8 88708.0 94406.5 95964.5 12035.8 12094.6 12155.5 13066.7 13212.2 14729.6 15228.9 15451.4 15575.0 15600.9 13929.1 14133.5 14167.6 14676.6 14981.6 14216.6 14363.5 14419.8 14537.2 14639.2 13705.8 14034.9 14182.5 14495.3 14648.9 11143.7 11373.1 11521.3 11624.8 11933.5 9771.4 10159.1 11554.8 11670.8 11700.4 05:35:48 INFO - PROCESS | 1656 | -------- Summary: end -------- 05:35:48 INFO - PROCESS | 1656 | 05:35:48 INFO - TEST-INFO | 1656: exit 0 05:35:48 INFO - TEST-OK | dromaeo_css | took 1114984ms 05:35:48 INFO - TEST-START | kraken 05:35:48 INFO - operating with platform_type : mac_ 05:35:48 INFO - Initialising browser for kraken test... 05:35:48 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpEhYNtb/profile http://localhost:49269/getInfo.html) 05:35:51 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:35:51 INFO - PROCESS | 1665 | colorDepth:24 05:35:51 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:35:51 INFO - PROCESS | 1665 | __metrics 05:35:51 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:35:51 INFO - PROCESS | 1665 | 05:35:51 INFO - PROCESS | 1665 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x10C000F,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 05:35:51 INFO - PROCESS | 1665 | 05:35:52 INFO - TEST-INFO | 1665: exit 0 05:35:52 INFO - Browser initialized. 05:35:52 INFO - Running cycle 1/1 for kraken test... 05:35:52 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpEhYNtb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:04 INFO - PROCESS | 1667 | RSS: Main: 239112192 05:36:04 INFO - PROCESS | 1667 | 05:36:07 INFO - PROCESS | 1667 | 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) 05:36:08 INFO - PROCESS | 1667 | RSS: Main: 252268544 05:36:08 INFO - PROCESS | 1667 | 05:36:10 INFO - PROCESS | 1667 | 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) 05:36:11 INFO - PROCESS | 1667 | RSS: Main: 260943872 05:36:11 INFO - PROCESS | 1667 | 05:36:14 INFO - PROCESS | 1667 | 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) 05:36:15 INFO - PROCESS | 1667 | RSS: Main: 263933952 05:36:15 INFO - PROCESS | 1667 | 05:36:17 INFO - PROCESS | 1667 | 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) 05:36:18 INFO - PROCESS | 1667 | RSS: Main: 265187328 05:36:18 INFO - PROCESS | 1667 | 05:36:20 INFO - PROCESS | 1667 | 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) 05:36:20 INFO - PROCESS | 1667 | RSS: Main: 265687040 05:36:20 INFO - PROCESS | 1667 | 05:36:23 INFO - PROCESS | 1667 | 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) 05:36:24 INFO - PROCESS | 1667 | RSS: Main: 266985472 05:36:24 INFO - PROCESS | 1667 | 05:36:27 INFO - PROCESS | 1667 | 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) 05:36:28 INFO - PROCESS | 1667 | RSS: Main: 267198464 05:36:28 INFO - PROCESS | 1667 | 05:36:31 INFO - PROCESS | 1667 | 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) 05:36:32 INFO - PROCESS | 1667 | RSS: Main: 267575296 05:36:32 INFO - PROCESS | 1667 | 05:36:33 INFO - PROCESS | 1667 | 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) 05:36:34 INFO - PROCESS | 1667 | RSS: Main: 267022336 05:36:34 INFO - PROCESS | 1667 | 05:36:36 INFO - PROCESS | 1667 | 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) 05:36:36 INFO - PROCESS | 1667 | RSS: Main: 267161600 05:36:36 INFO - PROCESS | 1667 | 05:36:39 INFO - PROCESS | 1667 | 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) 05:36:39 INFO - PROCESS | 1667 | RSS: Main: 267517952 05:36:39 INFO - PROCESS | 1667 | 05:36:42 INFO - PROCESS | 1667 | 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) 05:36:43 INFO - PROCESS | 1667 | RSS: Main: 267649024 05:36:43 INFO - PROCESS | 1667 | 05:36:46 INFO - PROCESS | 1667 | 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) 05:36:47 INFO - PROCESS | 1667 | RSS: Main: 267706368 05:36:47 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | 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) 05:36:48 INFO - PROCESS | 1667 | RSS: Main: 268673024 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | __start_tp_report 05:36:48 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:36:48 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:36:48 INFO - PROCESS | 1667 | |i|pagename|runs| 05:36:48 INFO - PROCESS | 1667 | |0;ai-astar;109;116;109;119;117;116;119;117;116;116 05:36:48 INFO - PROCESS | 1667 | |1;audio-beat-detection;141;117;172;194;100;159;162;142;177;110 05:36:48 INFO - PROCESS | 1667 | |2;audio-dft;203;213;235;197;196;198;196;198;201;194 05:36:48 INFO - PROCESS | 1667 | |3;audio-fft;73;77;75;142;59;59;59;58;133;58 05:36:48 INFO - PROCESS | 1667 | |4;audio-oscillator;70;73;125;72;72;93;113;72;95;140 05:36:48 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;88;90;89;135;128;90;87;90;130 05:36:48 INFO - PROCESS | 1667 | |6;imaging-darkroom;107;123;154;147;96;121;117;96;97;112 05:36:48 INFO - PROCESS | 1667 | |7;imaging-desaturate;88;135;149;122;143;108;115;111;146;125 05:36:48 INFO - PROCESS | 1667 | |8;json-parse-financial;56;58;59;56;57;58;59;73;57;58 05:36:48 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;63;69;69;71;78;76;76;70;69;71 05:36:48 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;86;89;89;88;84;88;87;90;111;114 05:36:48 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;137;140;139;138;142;151;155;164;167;142 05:36:48 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;176;181;178;177;180;181;186;186;244;178 05:36:48 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;70;69;69;71;67;69;67;69;70;69 05:36:48 INFO - PROCESS | 1667 | __end_tp_report 05:36:48 INFO - PROCESS | 1667 | __start_cc_report 05:36:48 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1056 05:36:48 INFO - PROCESS | 1667 | __end_cc_report 05:36:48 INFO - PROCESS | 1667 | __startTimestamp1471351008976__endTimestamp 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:36:48 INFO - PROCESS | 1667 | Number of tests: 14 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:3.57 (3.1%) stddev-sans-first:2.93 05:36:48 INFO - PROCESS | 1667 | Values: 109.0 116.0 109.0 119.0 117.0 116.0 119.0 117.0 116.0 116.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:160.50 stddev:30.98 (19.3%) stddev-sans-first:32.78 05:36:48 INFO - PROCESS | 1667 | Values: 141.0 117.0 172.0 194.0 100.0 159.0 162.0 142.0 177.0 110.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:203.10 Median:199.50 stddev:12.44 (6.2%) stddev-sans-first:13.20 05:36:48 INFO - PROCESS | 1667 | Values: 203.0 213.0 235.0 197.0 196.0 198.0 196.0 198.0 201.0 194.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:79.30 Median:59.00 stddev:31.66 (53.7%) stddev-sans-first:33.50 05:36:48 INFO - PROCESS | 1667 | Values: 73.0 77.0 75.0 142.0 59.0 59.0 59.0 58.0 133.0 58.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:72.00 stddev:25.57 (35.5%) stddev-sans-first:25.80 05:36:48 INFO - PROCESS | 1667 | Values: 70.0 73.0 125.0 72.0 72.0 93.0 113.0 72.0 95.0 140.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:101.70 Median:89.50 stddev:20.31 (22.7%) stddev-sans-first:21.10 05:36:48 INFO - PROCESS | 1667 | Values: 90.0 88.0 90.0 89.0 135.0 128.0 90.0 87.0 90.0 130.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:117.00 Median:150.50 stddev:20.35 (13.5%) stddev-sans-first:21.26 05:36:48 INFO - PROCESS | 1667 | Values: 107.0 123.0 154.0 147.0 96.0 121.0 117.0 96.0 97.0 112.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:124.20 Median:139.00 stddev:19.43 (14.0%) stddev-sans-first:15.58 05:36:48 INFO - PROCESS | 1667 | Values: 88.0 135.0 149.0 122.0 143.0 108.0 115.0 111.0 146.0 125.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.00 stddev:5.00 (8.6%) stddev-sans-first:5.17 05:36:48 INFO - PROCESS | 1667 | Values: 56.0 58.0 59.0 56.0 57.0 58.0 59.0 73.0 57.0 58.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:4.42 (6.2%) stddev-sans-first:3.55 05:36:48 INFO - PROCESS | 1667 | Values: 63.0 69.0 69.0 71.0 78.0 76.0 76.0 70.0 69.0 71.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:10.65 (12.1%) stddev-sans-first:11.02 05:36:48 INFO - PROCESS | 1667 | Values: 86.0 89.0 89.0 88.0 84.0 88.0 87.0 90.0 111.0 114.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:146.50 stddev:11.11 (7.6%) stddev-sans-first:11.11 05:36:48 INFO - PROCESS | 1667 | Values: 137.0 140.0 139.0 138.0 142.0 151.0 155.0 164.0 167.0 142.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:181.00 stddev:20.42 (11.3%) stddev-sans-first:21.29 05:36:48 INFO - PROCESS | 1667 | Values: 176.0 181.0 178.0 177.0 180.0 181.0 186.0 186.0 244.0 178.0 05:36:48 INFO - PROCESS | 1667 | 05:36:48 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 05:36:48 INFO - PROCESS | 1667 | Values: 70.0 69.0 69.0 71.0 67.0 69.0 67.0 69.0 70.0 69.0 05:36:48 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:36:48 INFO - PROCESS | 1667 | 05:36:49 INFO - TEST-INFO | 1667: exit 0 05:36:49 INFO - TEST-OK | kraken | took 61005ms 05:36:49 INFO - SUITE-END | took 1175s 05:36:50 INFO - Completed test suite (00:19:36) 05:36:50 INFO - javascript benchmark 05:36:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7334.585190962846, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3411.607665118512, 3414.3854106260874, 3448.6378930212327, 3466.445368741002, 3478.5130081788548, 4804.0, 5692.629979051364, 5719.542436605072, 5720.1991721159075, 5764.365919748835, 4894.608431325494, 5327.493888080636, 5680.233168522248, 5794.478496935286, 5823.505002074829, 5060.367454068241, 5237.685738855662, 5253.369595648527, 5282.366116066078, 5307.442718514559, 4400.031992961543, 5338.252644629735, 5353.9196912046355, 5405.621606487547, 5410.56715462764, 5130.333056702642, 5170.870728231786, 5302.098643230622, 5313.282706834567, 5318.46815318467, 4784.234522476422, 5190.455002224788, 5214.661047031968, 5216.66091704038, 5280.155175171954, 5185.196294574347, 5195.480451954812, 5195.792168313263, 5261.76322065508, 5322.0952438085615, 5560.415281644712, 5668.43315668434, 5698.088305871041, 5800.390958949291, 5817.505512031483, 6176.413240742122, 6179.104029915637, 6235.376462353774, 6242.094896240065, 6256.061590761422, 5429.267048948381, 5550.86122846928, 6201.751929922798, 6208.689565521706, 6215.1609532712955, 4664.300354946785, 4812.278158276216, 5010.849674509771, 5758.165066065397, 5805.01314776489, 6338.461230795342, 6342.4926005919415, 6346.746130154742, 6347.52393570484, 6359.427651511386, 6164.4143806338325, 6169.629822210682, 6199.3490683478485, 6201.007838745779, 6210.130581718563, 6135.386461353918, 6143.358355907003, 6170.969145154246, 6178.474829639441, 6207.379262073757, 5063.898722025612, 6157.138000679908, 6187.257529096537, 6192.071189321638, 6250.624962502265, 5696.8006119785605, 6204.906926396107, 6261.968690156611, 6279.120923070774, 6281.120643109877, 4877.365942427462, 4929.704217746947, 4935.679180853305, 4945.604351651859, 4952.479989601112, 4377.409049778303, 4431.158079964861, 4435.6895017349125, 4443.955560444419, 4501.504834468205, 5764.394738552475, 5841.88316233673, 5861.20873682056, 5868.941310586925, 5872.618279811799, 4965.90068198634, 6227.906581401192, 6235.906461403082, 6251.3123556408755, 6262.655553944577, 5814.418558144236, 5850.502707269845, 5854.7072646367515, 5858.121281807763, 5875.794347197828, 5458.972705136449, 5466.34403871538, 5471.398146203915, 5485.259489968883, 5500.972495137498, 6175.2898416681755, 6284.968575157095, 6295.244570651551, 6332.683365831598, 6381.521385895983, 6278.811635650938, 6287.434130928238, 6293.811185664437, 6295.0, 6299.779507717391, 6286.119943207863, 6366.236051673829, 6373.968130159319, 6387.361263873576, 6410.358964103552, 6086.087086936995, 6154.538409619386, 6164.568480206342, 6181.5363847710705, 6224.595401298901, 6301.905471417841, 6313.842153946004, 6321.557490975588, 6324.620522768465, 6336.112944187726, 6175.475084617858, 6185.381461853779, 6195.81412557624, 6202.28673702512, 6223.564350495421, 6004.729787159501, 6032.426919442646, 6114.510272098727, 6120.938790612215, 6173.969130154321, 5842.766289348378, 5850.970745146247, 6056.182415373868, 6059.33347331802, 6112.1748563945075, 6141.109539116714, 6156.076588511759, 6183.350748171377, 6187.938120618736, 6196.783112591038, 5857.26784151981, 5936.050231962865, 5975.940240597538, 6070.2412198475195, 6071.180390647382], "value": 5680.212557816909, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.9112750832359, 524.1063985904032, 525.1204232909877, 538.5395486858736, 540.1411755309058, 30549.84725076374, 41365.58634413655, 41411.58588414119, 41451.963700907494, 41477.37783933243, 42001.57998420015, 42460.363094553526, 42514.36228456576, 42595.36106958398, 42653.0, 9786.65746698864, 9952.303338766289, 9963.950180249089, 9981.901990781045, 9997.15024222942, 9774.462404567746, 9868.210543156567, 9899.109080182781, 9903.563983222428, 9925.106740393363, 8304.377171712116, 8747.650093996264, 8879.600417981206, 9437.386569872971, 9918.752031199241, 8394.622241999125, 9754.756131096708, 9793.020697930222, 9853.0, 9871.309008369417, 9693.515324233831, 9736.659216927374, 9756.951215243878, 9762.219022478184, 9801.607935682565, 38594.0, 40347.0, 40434.0, 40774.0, 40943.38584921229, 2650.4301575161435, 3273.1980664737052, 3321.335732853439, 3501.2647344057777, 3510.666486683761, 30281.848590757127, 30886.691133088607, 30979.380412391853, 31931.201719957186, 32031.839840800647, 2582.5093232285803, 3143.2613335866054, 3147.213196700825, 3149.9055028349185, 3165.0346644273486, 411411.0, 413746.0, 415625.0, 415986.0, 417365.91317043523, 33764.0, 33908.830455847565, 33924.42020327273, 33988.49017264743, 34008.149796254795, 33638.32723345568, 34046.0, 34178.14554636104, 34666.48000279998, 35438.0, 15202.0, 15369.846301536842, 15391.999520031162, 15396.0, 15453.5363939082, 11596.130290228266, 11727.824082638766, 11738.002269806992, 11752.177347585586, 11770.940615344489, 15615.375384984472, 19152.138153783115, 19200.231990720495, 19206.519837004187, 19245.326413575458, 7279.490435669558, 8018.879716804253, 8046.275835174863, 8132.796680083045, 8201.95899020513, 756.7994481462417, 900.2482926756232, 940.1150692860907, 1018.6842078955548, 1090.96903426263, 28066.2983425416, 29716.0, 30911.0, 31315.686843131276, 31850.26695194887, 993.1657407777501, 1020.8111499372492, 1052.8210204265292, 1057.5981127171626, 1129.1869853705318, 16039.679206415807, 16197.83802161987, 16208.51374458768, 16230.756538651929, 16610.418635347945, 636320.0, 641278.0, 642302.0, 643492.5650743527, 645011.0, 50775.73060673439, 59114.40885591175, 59648.0, 60313.69843150756, 60320.39679603236, 1348.1776116568885, 1371.739369519788, 1391.7355702416507, 1391.9768969807183, 1394.0868730981224, 29449.263768405963, 31032.68967310298, 32005.839970799996, 32538.0, 32570.0, 57202.7139864298, 58106.0, 58133.83732325414, 58271.4172858283, 58337.70831145987, 625344.0, 628011.0, 630926.0, 630989.0, 631260.0, 44235.55764442314, 44539.55460445484, 45034.0, 45113.32330014987, 45118.0, 49066.75466622787, 49314.50685493243, 49841.0, 50630.24054639257, 50775.2383714252, 34029.65970340364, 39927.0, 40192.0, 41298.0, 41321.380179297936, 33156.00531984044, 38440.423393649675, 39398.04514661354, 41325.586744132175, 41332.58667413408, 30031.84984075153, 38544.03639909025, 39219.607803922736, 39544.60455395524, 39943.80028099841, 34356.82821585976, 35012.0, 35826.820865895505, 35906.82046589855, 36185.27629447449, 21375.931203439453, 22844.0, 24467.43091975317, 25188.874055629603, 25936.0], "value": 19649.78466013247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.71216534193945, 354.6205560050744, 370.8794641741435, 372.8415423445035, 398.0446927374301, 20098.296559620416, 20116.295929642467, 20585.38243852683, 21172.57654846902, 21450.927453627333, 19176.712349314737, 19371.128299226533, 19671.606567868635, 19680.212791488324, 20045.498862528446, 5399.9730001350035, 5465.426130256325, 5571.693556854371, 5576.804811831586, 5925.525957923356, 6090.66501342426, 6220.688965551727, 6230.8442288942915, 6251.12484252205, 6263.0, 6233.594816336947, 6239.469645080174, 6305.810825675214, 6912.619805910673, 6958.826029349256, 6396.456301214403, 6915.481338899603, 6917.0, 6974.546654467444, 6985.301469853, 6055.212822333068, 6132.662703551303, 6132.7240274187325, 6135.938640613582, 6148.569600127993, 13547.45810167592, 13621.978351623668, 13776.24230667313, 13813.102148360324, 13964.022518423715, 2157.7194964654495, 2183.1049269799464, 2289.5077558324874, 2556.0, 2647.377866201441, 9870.309078364517, 10530.684079477627, 10686.839697404544, 11421.343905133708, 13070.803937940938, 1724.5257554172576, 1912.4071537823181, 1920.5102698811854, 1965.8329042031444, 1987.7217189593468, 115307.0, 122372.0, 125240.37379813133, 126485.47029059367, 127892.36053819764, 9290.0, 10767.946160269148, 11253.81834907323, 11513.654590362303, 11754.764904701859, 12008.0, 14046.367913443919, 14380.712385752226, 14467.855321446861, 14504.927475362556, 7962.601869906482, 8179.713710020121, 8209.95895020533, 8334.791630209293, 8356.080831108573, 7914.643841027168, 7992.960035199903, 7999.480033797785, 8120.106788253287, 8160.795980100545, 3583.8566457341412, 3955.7626542407547, 4419.558044195554, 4547.909041819145, 4580.129775342674, 1934.6204168872084, 1976.1403789351677, 1986.692062730279, 2012.4465771912842, 2023.6357455657828, 850.1753299299669, 870.9216170544555, 888.7379920512888, 1003.5433877585681, 1059.692689120162, 20304.69542956857, 21177.470563236042, 21885.67171492429, 21917.0, 22209.777902220772, 754.5359603843706, 777.5995362388375, 913.2648218184293, 945.6926498887889, 1005.9144972677258, 10110.69667909964, 10576.788464230673, 11131.109511239081, 11671.183017188885, 11683.883161168449, 562184.0, 563192.1840390771, 574541.0, 582895.0, 625376.0, 75690.0, 130057.69942300455, 130161.0, 134992.32503837417, 146387.0, 965.7778710896533, 1006.5621454667244, 1039.428314427062, 1041.0578426524007, 1043.3791893823163, 17859.553511162325, 19717.507062323555, 19769.11039003277, 19951.60096798027, 20228.08973596221, 57309.0, 57759.71120144372, 57783.0, 58199.83600327885, 58425.0, 73865.0, 76973.0, 79199.20800791918, 81415.18584814075, 86489.0, 7655.928170056085, 7785.260400261966, 7918.970533830565, 8183.754487365389, 8239.711610093618, 9470.384425012353, 11085.390303533382, 13348.265845378597, 13842.307884605529, 13874.167549947035, 11382.886171138183, 11534.942325288655, 11685.532578697097, 11749.236299640495, 11783.646490605295, 10402.375857448576, 10518.474076296308, 11443.599474018702, 11528.481218345363, 11853.822192666945, 11345.0, 11424.771504570028, 11616.94191529037, 11727.413629318671, 12112.636620901387, 8137.186281371815, 8143.18568143181, 8420.242178203991, 8505.87241191395, 8595.871061934202, 9428.245740340893, 9881.85177222328, 11013.953674400918, 11584.247023943417, 11717.76564468723], "value": 9523.532922198456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.9035462694922, 1523.8247601525825, 1709.6751617192733, 1806.3226290141197, 1858.2845604442293, 7606.733764318236, 8174.2234487723645, 8256.091829898707, 8643.178898004688, 8648.437851539662, 8324.50052996819, 8471.237588617023, 8480.067192608809, 8492.787680307996, 8493.49039057657, 1954.7263383126374, 2268.7731226877263, 2304.539092181562, 2306.08909480755, 2309.607366747657, 1768.9203985820604, 1814.28335807356, 2016.737824082867, 2166.8916554172306, 2315.81473482121, 2261.9660705089436, 2284.497410569672, 2285.897134628946, 2295.9897645036212, 2322.1872344679396, 2268.2288022072494, 2281.3498153026308, 2291.6562515622622, 2299.494111295512, 2302.1597117052324, 2278.225403362848, 2281.6349384098467, 2284.0521183708743, 2287.0508738873345, 2295.5753185660537, 7177.89233161503, 8516.957415212946, 8522.232999030117, 8643.913560864374, 8658.177473140042, 4928.778204980785, 5061.949380506185, 5088.694678319275, 5092.949070509321, 5094.2103973884105, 3337.2324365396094, 3409.3522230776075, 3494.9864539283576, 3534.68187863091, 3545.149164200573, 1057.2070946789909, 1064.6486659402378, 1065.7868426314767, 1067.9572817087308, 1085.4952447112053, 10918.1811364148, 10941.83587246192, 11040.558377664884, 11054.115670746321, 11071.391073490955, 4433.82264709408, 4533.84131555394, 4562.84030058953, 4688.296755486705, 4689.601383882408, 9266.166045055978, 9352.251819854395, 9361.110694484014, 9364.391314564531, 9366.203872670763, 4980.5019498049905, 5035.647504674711, 5037.823676171316, 5089.312942752681, 5093.312402825645, 4230.598093181143, 4555.088982203572, 4705.741184234831, 4724.574788269072, 4733.715977041388, 3800.277947190025, 3818.3581060144406, 3884.708646851441, 3909.8240579174008, 3913.8238779255003, 1265.221888538542, 1272.5164437513686, 1277.2272774971195, 1277.6039427777418, 1283.9037072219621, 755.0, 851.8679604661287, 894.8926128864578, 898.8382091223511, 909.4452384045727, 4647.837325693652, 5834.708264586754, 5889.617174883619, 5891.646501209942, 5898.0, 867.9783005424789, 879.2087121590491, 902.4495058014605, 941.087145468894, 1040.4860927350687, 3780.8865734028022, 3798.7910664913143, 3814.599467055975, 3987.043109653662, 3989.880303590897, 10002.349847259904, 10206.234532410099, 10250.58997640101, 10257.58969641221, 10273.229507786946, 9467.621295148117, 9961.35251208669, 10220.02909723575, 10226.13077888373, 10303.74240643975, 7827.804304892423, 7991.760247192594, 8008.439409241414, 8028.558429286329, 8029.4379393441895, 5074.847754567369, 5409.053415652324, 5610.85972850682, 5873.119032145212, 5960.612560183574, 9195.632174713204, 9624.51877406141, 9738.513074346396, 9742.269329800152, 9747.610095596097, 9442.433453992782, 9766.316357854881, 9776.706698799047, 9907.306488545733, 9917.206623470249, 5197.4282828889545, 5827.329857066492, 6857.108575885103, 7206.135263768172, 7303.926960730325, 8153.673853046049, 8221.958890205511, 8223.506589604644, 8227.629756660845, 8262.83474330522, 7256.129264488295, 7349.007883935814, 7410.333070023724, 7421.480496365202, 7507.587082710504, 6214.40963108504, 7189.712411503481, 7267.236940121211, 7268.96365518169, 7311.926880731125, 6610.338966103352, 6712.395884370235, 6773.491988101011, 6784.966075169593, 6785.287544807921, 4738.478767335521, 4804.183288840835, 4814.542618451242, 4861.829835955725, 4906.09237291088, 4732.432108147044, 4755.215389460838, 4853.247746599282, 4904.068227036852, 5024.296598476143], "value": 4420.219055208486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.22442140538266, 298.8938926681028, 305.32370798680915, 307.19974466514714, 311.14125014958705, 4865.9781445896315, 4890.926636100461, 4902.583280421169, 5261.76322065507, 5651.858703532409, 4117.135401565667, 5613.915791263124, 5649.107548971099, 5666.603337766348, 5667.206591077253, 3735.495708079415, 3782.262458820517, 4322.935155972663, 4331.960329520924, 4345.69580129391, 3979.900502487432, 3999.060220848098, 4227.344761561947, 4300.827966881321, 4364.650827933758, 3460.757746957714, 3483.7909725416557, 4211.68412369072, 4221.683373746966, 4277.850275240367, 3402.7788193767324, 4181.808184667386, 4214.473190851144, 4218.641415479658, 4229.471316085504, 3637.854485820564, 3646.5441819772527, 3657.5428071491065, 3660.3411385950517, 3675.8345874435713, 4346.913061738747, 5371.704556249405, 5426.375966763833, 5445.156000819839, 5531.0, 4263.658907287409, 4600.769961501945, 4777.737224452654, 4780.880477988043, 4880.292357608127, 5034.320366750479, 5159.871003224912, 5906.645601263938, 5933.664925391796, 6007.61824780303, 3497.807620580867, 3723.4973278607313, 3936.8937618374034, 3942.7437216581116, 3949.8420063197723, 6089.665068421235, 6116.602420842631, 6321.273053598849, 6394.168758061469, 6425.357464253584, 3514.578250609892, 3541.4333706606817, 3941.9802900985887, 3969.947963789598, 4049.493813273341, 3679.981600092036, 3719.9584116447436, 3803.4294855771304, 4126.7523948563185, 4134.4005119258145, 4826.517348265145, 4828.5412885775795, 4858.222684370484, 4870.951290487121, 4879.413630981297, 4985.277134815431, 5282.445343238905, 5293.814716484904, 6031.220789866999, 6149.446549810449, 1324.0136098606408, 1329.3751936589788, 1373.169232614274, 1384.806127142201, 1406.8955869642487, 801.7755028592004, 889.9765269939621, 921.1755478846395, 939.3565407695751, 946.7538440005649, 4817.855464336076, 5613.8596535086135, 5660.632058916157, 5667.943320566742, 5710.5146062585145, 5917.615355001911, 6167.506599472032, 6192.792405480888, 6262.248530176317, 6285.528585356116, 5313.707746074003, 5551.472610102034, 5616.977887960331, 5648.717564121777, 5681.289838770153, 2634.89460421581, 2741.5606806426786, 2760.4341110072387, 2793.846338451405, 2798.5522316429274, 4315.136972605492, 4654.627629789608, 5089.083964886282, 5390.385662953543, 5415.729213539307, 4980.028894365636, 5884.558658100659, 6108.877822443526, 6420.422162005442, 6537.607743535403, 6555.606663600009, 6557.278699343068, 6588.8023359299295, 6589.47284217271, 6594.868102638016, 5833.191710569737, 6032.1856549365275, 6274.843128921813, 6396.0405939109505, 6396.680165991589, 5110.61670374716, 6019.668918209541, 6240.875182496416, 6244.2819075806865, 6257.937420625917, 5563.554915606823, 6583.967080164569, 6604.702788374439, 6611.371919667624, 6646.136002319668, 3555.9687690569444, 3650.8904732858055, 3974.4634474345594, 4090.570490098497, 4117.958820411877, 5983.311919129182, 6296.677697683354, 6305.563467910092, 6330.588511746721, 6374.553781235269, 4936.605071594336, 5422.457754224546, 5767.9134812977, 6049.485793707584, 6072.72672729737, 4800.423949126127, 6057.848553786191, 6070.423309785563, 6087.117367981707, 6134.539909506894, 4635.6986795858165, 5748.798792042258, 5883.823485295276, 5929.7547515022325, 6036.426539478743, 5909.468147866541, 6008.369121242206, 6014.1957412776865, 6051.364606716232, 6067.362926892612, 4499.662525310549, 5208.348956380452, 5973.372795856372, 5993.460588547052, 6010.098485227076], "value": 4265.177510464073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.3183153183753, 710.1159056974068, 714.8954864733986, 715.706560310273, 728.497336837582, 12922.353882305883, 15085.396584136648, 15525.611859703513, 15701.528954131394, 15709.057456552615, 14462.783058254134, 14478.782818257734, 14580.270986450689, 14581.489647862327, 14601.0, 675.5845155229523, 840.7645859159445, 860.4837097741367, 864.0840708848641, 866.0300463480879, 832.2883934236231, 848.6266042941086, 859.0893652728097, 866.6923242249005, 868.5309932636369, 900.8288425199224, 903.0337538833451, 903.588867065487, 904.4482865452069, 909.2862103248951, 863.8488264553678, 894.789724414762, 895.6909866096187, 895.8880139982502, 897.3583887520422, 657.3557913244999, 661.6625520984285, 665.3845193196322, 666.7632990288474, 668.4184759259475, 14813.629659258497, 15012.174330411823, 15021.399144034225, 15042.849571504254, 15050.172240526766, 14572.781408278885, 14651.0, 14858.405663773436, 14994.70010599782, 15032.849671503363, 11996.340201288926, 12062.336571488564, 12192.207506512137, 12390.31853248071, 12411.379431028503, 3862.1310205203886, 3894.7663140211394, 3996.7402118862474, 4068.2677118118727, 4132.979335103335, 106616.46691766569, 108661.0, 108823.0, 109734.0, 109919.0, 10873.782524349468, 11279.266847654877, 11336.991706695571, 11416.771664566828, 11825.349605771766, 23451.530969380517, 23495.41261468477, 23507.17724879621, 23553.175638852557, 23575.646365304536, 7594.0, 7698.96150519255, 8146.266835984789, 8307.335413166933, 8431.873521897176, 4457.554244575581, 4539.84110556129, 4549.294859296814, 4560.315952607069, 4564.2240819060835, 3417.743669224818, 3532.3111993161087, 3545.149164200573, 3559.199180184438, 3563.768355056913, 534.0760484361998, 546.5955193157035, 605.857623458487, 620.3021600699213, 623.2240860129168, 452.07324983783116, 514.6963291657939, 514.7080827123946, 625.0811307378146, 628.5129025005566, 8592.8711069334, 8641.956790216134, 8648.740537783751, 9773.364731292444, 10085.445300508396, 466.5031741195616, 517.8938317644873, 584.8917950179231, 613.5735663713676, 657.572577824418, 3850.5764365919727, 3890.9416358754643, 4520.50274469808, 4668.85993420198, 4722.811087556528, 141657.29171354076, 144306.0, 153231.23384383006, 153643.0, 154219.0, 120311.0, 124895.0, 130863.34568327098, 131213.0, 131638.34180829034, 94643.0, 112162.0, 114105.42947285376, 118190.0, 118380.0, 8739.431936924333, 9022.278217742434, 9074.228690561376, 9128.406653567497, 9176.0, 46520.0, 47786.0, 58127.418725812204, 60330.396696032476, 63274.050889235776, 76811.61594191994, 80243.79634305373, 88708.0, 94406.52796735973, 95964.52017739866, 12035.819462708241, 12094.637160885188, 12155.513779448724, 13066.738665226452, 13212.207267563977, 14729.55811325662, 15228.923855380652, 15451.381944722534, 15575.0, 15600.92199538995, 13929.094608850392, 14133.505327313906, 14167.64580885445, 14676.55970320892, 14981.550553483414, 14216.57350279452, 14363.497277595234, 14419.78370324425, 14537.200453975132, 14639.194844283667, 13705.794413084011, 14034.859651403764, 14182.503612373517, 14495.347709352893, 14648.926755366156, 11143.72140696489, 11373.14701397382, 11521.308721476738, 11624.76750464969, 11933.52265909354, 9771.413715177112, 10159.115681131672, 11554.826677599674, 11670.824937625772, 11700.414979250832], "value": 7767.962286819737, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1606.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 109.0, 119.0, 117.0, 116.0, 119.0, 117.0, 116.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 172.0, 194.0, 100.0, 159.0, 162.0, 142.0, 177.0, 110.0], "value": 147.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 213.0, 235.0, 197.0, 196.0, 198.0, 196.0, 198.0, 201.0, 194.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 142.0, 59.0, 59.0, 59.0, 58.0, 133.0, 58.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 125.0, 72.0, 72.0, 93.0, 113.0, 72.0, 95.0, 140.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 90.0, 89.0, 135.0, 128.0, 90.0, 87.0, 90.0, 130.0], "value": 101.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 123.0, 154.0, 147.0, 96.0, 121.0, 117.0, 96.0, 97.0, 112.0], "value": 117.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 135.0, 149.0, 122.0, 143.0, 108.0, 115.0, 111.0, 146.0, 125.0], "value": 124.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 59.0, 56.0, 57.0, 58.0, 59.0, 73.0, 57.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 69.0, 71.0, 78.0, 76.0, 76.0, 70.0, 69.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 89.0, 88.0, 84.0, 88.0, 87.0, 90.0, 111.0, 114.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 139.0, 138.0, 142.0, 151.0, 155.0, 164.0, 167.0, 142.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 181.0, 178.0, 177.0, 180.0, 181.0, 186.0, 186.0, 244.0, 178.0], "value": 186.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 71.0, 67.0, 69.0, 67.0, 69.0, 70.0, 69.0], "value": 69.0, "unit": "score"}]}]} 05:36:50 INFO - Return code: 0 05:36:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:50 ERROR - # TBPL SUCCESS # 05:36:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:50 INFO - 2016-08-16 05:36:50.297 screenresolution[1672:10505] starting screenresolution argv=screenresolution get 05:36:50 INFO - 2016-08-16 05:36:50.300 screenresolution[1672:10505] Display 0: 1600x1200x32@60 05:36:50 INFO - 2016-08-16 05:36:50.305 screenresolution[1673:10508] starting screenresolution argv=screenresolution list 05:36:50 INFO - Available Modes on Display 0 05:36:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:50 INFO - Intel Iris: 05:36:50 INFO - Chipset Model: Intel Iris 05:36:50 INFO - Type: GPU 05:36:50 INFO - Bus: Built-In 05:36:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:50 INFO - Vendor: Intel (0x8086) 05:36:50 INFO - Device ID: 0x0a2e 05:36:50 INFO - Revision ID: 0x0009 05:36:50 INFO - Displays: 05:36:50 INFO - Display: 05:36:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:50 INFO - Display Serial Number: 1600x1200 60 05:36:50 INFO - Main Display: Yes 05:36:50 INFO - Mirror: Off 05:36:50 INFO - Online: Yes 05:36:50 INFO - Rotation: Supported 05:36:50 INFO - Return code: 0 05:36:50 INFO - Running post-action listener: _resource_record_post_action 05:36:50 INFO - [mozharness: 2016-08-16 12:36:50.542624Z] Finished run-tests step (success) 05:36:50 INFO - Running post-run listener: _resource_record_post_run 05:36:50 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 44619264; Write bytes: 707686400; Read time: 431; Write time: 2155 05:36:50 INFO - TinderboxPrint: CPU usage
54.4% 05:36:50 INFO - TinderboxPrint: I/O read bytes / time
44,619,264 / 431 05:36:50 INFO - TinderboxPrint: I/O write bytes / time
707,686,400 / 2,155 05:36:50 INFO - TinderboxPrint: CPU idle
2,210.5 (45.6%) 05:36:50 INFO - TinderboxPrint: CPU system
981.3 (20.3%) 05:36:50 INFO - TinderboxPrint: CPU user
1,653.9 (34.1%) 05:36:50 INFO - TinderboxPrint: Swap in / out
457,535,488 / 0 05:36:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394408448; Write bytes: 389273600; Read time: 29653; Write time: 763 05:36:50 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 42702336; Write bytes: 298407936; Read time: 408; Write time: 1346 05:36:51 INFO - Running post-run listener: _upload_blobber_files 05:36:51 INFO - Blob upload gear active. 05:36:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:36:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:36:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:52 INFO - (blobuploader) - INFO - Done attempting. 05:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:53 INFO - (blobuploader) - INFO - Done attempting. 05:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:55 INFO - (blobuploader) - INFO - Done attempting. 05:36:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:55 INFO - Return code: 0 05:36:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f54be543cbe3fb76c1f82eba93eca6ac6dbbe504a9216789aa5d4e8c3995d4d3cc8603e06c8022c33cbeabb8493b505dfa6a93586848c0c9e2e508033469b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6447de81ccf87ca47076f1896de76ad2cad865e197630665f80dafd171e33ed3992d2db7d13aa8aaac8bb2a882e8e4965314db01d882bf3b50055de45a2d69cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480bfe21aa0ad6023b1787b68ef7ca578acfd8259e6a087f5758d466cb8d15f291928c7588f08c93ce692531a4ebb88dbd072200d29d3ee9786323bed6b9a167"} 05:36:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:55 INFO - Contents: 05:36:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f54be543cbe3fb76c1f82eba93eca6ac6dbbe504a9216789aa5d4e8c3995d4d3cc8603e06c8022c33cbeabb8493b505dfa6a93586848c0c9e2e508033469b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6447de81ccf87ca47076f1896de76ad2cad865e197630665f80dafd171e33ed3992d2db7d13aa8aaac8bb2a882e8e4965314db01d882bf3b50055de45a2d69cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480bfe21aa0ad6023b1787b68ef7ca578acfd8259e6a087f5758d466cb8d15f291928c7588f08c93ce692531a4ebb88dbd072200d29d3ee9786323bed6b9a167"} 05:36:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:55 INFO - Copying logs to upload dir... 05:36:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.935497 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-16 05:36:55.976480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:55.980930) ========= 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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/Fx-Team/sha512/51f54be543cbe3fb76c1f82eba93eca6ac6dbbe504a9216789aa5d4e8c3995d4d3cc8603e06c8022c33cbeabb8493b505dfa6a93586848c0c9e2e508033469b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6447de81ccf87ca47076f1896de76ad2cad865e197630665f80dafd171e33ed3992d2db7d13aa8aaac8bb2a882e8e4965314db01d882bf3b50055de45a2d69cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480bfe21aa0ad6023b1787b68ef7ca578acfd8259e6a087f5758d466cb8d15f291928c7588f08c93ce692531a4ebb88dbd072200d29d3ee9786323bed6b9a167"} build_url:https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010999 build_url: 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51f54be543cbe3fb76c1f82eba93eca6ac6dbbe504a9216789aa5d4e8c3995d4d3cc8603e06c8022c33cbeabb8493b505dfa6a93586848c0c9e2e508033469b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6447de81ccf87ca47076f1896de76ad2cad865e197630665f80dafd171e33ed3992d2db7d13aa8aaac8bb2a882e8e4965314db01d882bf3b50055de45a2d69cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/480bfe21aa0ad6023b1787b68ef7ca578acfd8259e6a087f5758d466cb8d15f291928c7588f08c93ce692531a4ebb88dbd072200d29d3ee9786323bed6b9a167"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:56.014755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:56.015376) ========= 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.NRRA5Q0JEe/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.Jk8qHWgfMq/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005123 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:56.065848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:36:56.066119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:36:56.066556) ========= ========= Total master_lag: 0.39 =========