builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1471540145.98 results: success (0) buildid: 20160818063655 builduid: 382f62e4393d4ff280081d04d1e39925 revision: 7db43c31bdb7b4070e2e676022d39e81003c0d4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:05.975976) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:05.976881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:05.977459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:06.001669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:06.002283) ========= 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.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-18 10:09:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2016-08-18 10:09:06 (14.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:06.128091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:06.128379) ========= 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.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.021610 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:06.176376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 10:09:06.176717) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7db43c31bdb7b4070e2e676022d39e81003c0d4f --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 7db43c31bdb7b4070e2e676022d39e81003c0d4f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-18 10:09:06,252 truncating revision to first 12 chars 2016-08-18 10:09:06,253 Setting DEBUG logging. 2016-08-18 10:09:06,253 attempt 1/10 2016-08-18 10:09:06,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7db43c31bdb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 10:09:07,357 unpacking tar archive at: fx-team-7db43c31bdb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368746 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 10:09:07.571279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:07.572051) ========= script_repo_revision: 7db43c31bdb7b4070e2e676022d39e81003c0d4f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:07.572924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:07.573230) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 10:09:07.592996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-18 10:09:07.593322) ========= /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.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:07 INFO - MultiFileLogger online at 20160818 10:09:07 in /builds/slave/test 10:09:07 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 10:09:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:09:07 INFO - {'append_to_log': False, 10:09:07 INFO - 'base_work_dir': '/builds/slave/test', 10:09:07 INFO - 'blob_upload_branch': 'Fx-Team', 10:09:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:09:07 INFO - 'branch': 'Fx-Team', 10:09:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:09:07 INFO - 'config_files': ('talos/mac_config.py',), 10:09:07 INFO - 'default_actions': ('clobber', 10:09:07 INFO - 'read-buildbot-config', 10:09:07 INFO - 'download-and-extract', 10:09:07 INFO - 'populate-webroot', 10:09:07 INFO - 'create-virtualenv', 10:09:07 INFO - 'install', 10:09:07 INFO - 'run-tests'), 10:09:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:09:07 INFO - 'download_minidump_stackwalk': True, 10:09:07 INFO - 'download_symbols': 'ondemand', 10:09:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:09:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:09:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:09:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:09:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:09:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:09:07 INFO - 'installer_path': 'installer.exe', 10:09:07 INFO - 'log_level': 'info', 10:09:07 INFO - 'log_name': 'talos', 10:09:07 INFO - 'log_to_console': True, 10:09:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:09:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:09:07 INFO - 'opt_config_files': (), 10:09:07 INFO - 'pip_index': False, 10:09:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:07 INFO - 'cmd': ('bash', 10:09:07 INFO - '-c', 10:09:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:07 INFO - 'enabled': True, 10:09:07 INFO - 'halt_on_failure': False, 10:09:07 INFO - 'name': 'check_screen_resolution'},), 10:09:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:09:07 INFO - 'cmd': ('bash', 10:09:07 INFO - '-c', 10:09:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:09:07 INFO - 'enabled': True, 10:09:07 INFO - 'halt_on_failure': False, 10:09:07 INFO - 'name': 'check_screen_resolution'},), 10:09:07 INFO - 'run_cmd_checks_enabled': True, 10:09:07 INFO - 'sps_profile': False, 10:09:07 INFO - 'sps_profile_interval': 0, 10:09:07 INFO - 'suite': 'dromaeojs-e10s', 10:09:07 INFO - 'system_bits': '32', 10:09:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:09:07 INFO - 'title': 't-yosemite-r7-0071', 10:09:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:09:07 INFO - 'use_talos_json': True, 10:09:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:09:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:09:07 INFO - 'work_dir': 'build'} 10:09:07 INFO - [mozharness: 2016-08-18 17:09:07.784586Z] Running clobber step. 10:09:07 INFO - Running pre-action listener: _resource_record_pre_action 10:09:07 INFO - Running main action method: clobber 10:09:07 INFO - rmtree: /builds/slave/test/build 10:09:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:09:09 INFO - Running post-action listener: _resource_record_post_action 10:09:09 INFO - [mozharness: 2016-08-18 17:09:09.832578Z] Finished clobber step (success) 10:09:09 INFO - [mozharness: 2016-08-18 17:09:09.832745Z] Running read-buildbot-config step. 10:09:09 INFO - Running pre-action listener: _resource_record_pre_action 10:09:09 INFO - Running main action method: read_buildbot_config 10:09:09 INFO - Using buildbot properties: 10:09:09 INFO - { 10:09:09 INFO - "project": "", 10:09:09 INFO - "product": "firefox", 10:09:09 INFO - "script_repo_revision": "production", 10:09:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:09:09 INFO - "repository": "", 10:09:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:09:09 INFO - "buildid": "20160818063655", 10:09:09 INFO - "pgo_build": "False", 10:09:09 INFO - "basedir": "/builds/slave/test", 10:09:09 INFO - "buildnumber": 91, 10:09:09 INFO - "slavename": "t-yosemite-r7-0071", 10:09:09 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:09:09 INFO - "platform": "yosemite_r7", 10:09:09 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:09:09 INFO - "branch": "fx-team", 10:09:09 INFO - "repo_path": "integration/fx-team", 10:09:09 INFO - "revision": "7db43c31bdb7b4070e2e676022d39e81003c0d4f", 10:09:09 INFO - "stage_platform": "macosx64", 10:09:09 INFO - "builduid": "382f62e4393d4ff280081d04d1e39925", 10:09:09 INFO - "slavebuilddir": "test" 10:09:09 INFO - } 10:09:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:09:09 INFO - Running post-action listener: _resource_record_post_action 10:09:09 INFO - [mozharness: 2016-08-18 17:09:09.835918Z] Finished read-buildbot-config step (success) 10:09:09 INFO - [mozharness: 2016-08-18 17:09:09.836030Z] Running download-and-extract step. 10:09:09 INFO - Running pre-action listener: _resource_record_pre_action 10:09:09 INFO - Running main action method: download_and_extract 10:09:09 INFO - mkdir: /builds/slave/test/build/tests 10:09:09 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')]} 10:09:09 INFO - trying https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:09:09 INFO - Downloading https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:11 INFO - Downloaded 1199 bytes. 10:09:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:09:11 INFO - Using the following test package requirements: 10:09:11 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:09:11 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:09:11 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:09:11 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'jsshell-mac.zip'], 10:09:11 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:09:11 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:09:11 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:09:11 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:09:11 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:09:11 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:09:11 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:09:11 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:09: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')]} 10:09:11 INFO - trying https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:09:11 INFO - Downloading https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:12 INFO - Downloaded 16339500 bytes. 10:09:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:09:19 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 10:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:19 INFO - trying https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:20 INFO - Downloaded 16339500 bytes. 10:09:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:26 INFO - trying https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:09:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:28 INFO - Downloaded 14413981 bytes. 10:09:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:28 INFO - trying https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:09:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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 10:09:31 INFO - Downloaded 111293487 bytes. 10:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:09:31 INFO - mkdir: /builds/slave/test/properties 10:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:09:31 INFO - Contents: 10:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:09:31 INFO - Running post-action listener: _resource_record_post_action 10:09:31 INFO - Running post-action listener: set_extra_try_arguments 10:09:31 INFO - [mozharness: 2016-08-18 17:09:31.947463Z] Finished download-and-extract step (success) 10:09:31 INFO - [mozharness: 2016-08-18 17:09:31.947585Z] Running populate-webroot step. 10:09:31 INFO - Running pre-action listener: _resource_record_pre_action 10:09:31 INFO - Running main action method: populate_webroot 10:09:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:09:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:09:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:09:31 INFO - '--tppagecycles', 10:09:31 INFO - '7'], 10:09:31 INFO - 'tests': ['tsvgm']}}, 10:09:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:09:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:09:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:09:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:09:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:09:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['damp', 'tps']}, 10:09:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'tests': ['damp', 'tps']}, 10:09:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['dromaeo_dom']}, 10:09:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:09:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['basic_compositor_video']}, 10:09:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:09:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['a11yr', 10:09:31 INFO - 'ts_paint', 10:09:31 INFO - 'tpaint', 10:09:31 INFO - 'sessionrestore', 10:09:31 INFO - 'sessionrestore_no_auto_restore', 10:09:31 INFO - 'tabpaint']}, 10:09:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['tsvgx', 10:09:31 INFO - 'tsvgr_opacity', 10:09:31 INFO - 'tart', 10:09:31 INFO - 'tscrollx', 10:09:31 INFO - 'cart']}, 10:09:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:09:31 INFO - 'tsvgr_opacity', 10:09:31 INFO - 'tart', 10:09:31 INFO - 'tscrollx', 10:09:31 INFO - 'cart']}, 10:09:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'talos_options': ['--disable-e10s'], 10:09:31 INFO - 'tests': ['tp5o']}, 10:09:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'tests': ['tp5o']}, 10:09:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'talos_options': ['--disable-e10s', 10:09:31 INFO - '--xperf_path', 10:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:31 INFO - 'tests': ['tp5n']}, 10:09:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:09:31 INFO - 'talos_options': ['--xperf_path', 10:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:09:31 INFO - 'tests': ['tp5n']}}, 10:09:31 INFO - 'talos.zip': {'path': '', 10:09:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:09:31 INFO - Running post-action listener: _resource_record_post_action 10:09:31 INFO - [mozharness: 2016-08-18 17:09:31.966030Z] Finished populate-webroot step (success) 10:09:31 INFO - [mozharness: 2016-08-18 17:09:31.966177Z] Running create-virtualenv step. 10:09:31 INFO - Running pre-action listener: _resource_record_pre_action 10:09:31 INFO - Running main action method: create_virtualenv 10:09:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:09:31 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 10:09:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:09:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:09:32 INFO - Using real prefix '/tools/python27' 10:09:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:09:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:09:35 INFO - Installing pip.................done. 10:09:35 INFO - Return code: 0 10:09:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:09:35 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')]} 10:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:35 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')]} 10:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:35 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:35 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 10:09:35 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 10:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:35 INFO - 'HOME': '/Users/cltbld', 10:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:35 INFO - 'LOGNAME': 'cltbld', 10:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:35 INFO - 'MOZ_NO_REMOTE': '1', 10:09:35 INFO - 'NO_EM_RESTART': '1', 10:09:35 INFO - 'PAGER': '/bin/cat', 10:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:35 INFO - 'PWD': '/builds/slave/test', 10:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:35 INFO - 'SHELL': '/bin/bash', 10:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:35 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:35 INFO - 'USER': 'cltbld', 10:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:35 INFO - 'XPC_FLAGS': '0x0', 10:09:35 INFO - 'XPC_SERVICE_NAME': '0', 10:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:35 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 10:09:35 INFO - Cleaning up... 10:09:35 INFO - Return code: 0 10:09:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:09:35 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')]} 10:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:35 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')]} 10:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:35 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:35 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 10:09:35 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 10:09:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:35 INFO - 'HOME': '/Users/cltbld', 10:09:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:35 INFO - 'LOGNAME': 'cltbld', 10:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:35 INFO - 'MOZ_NO_REMOTE': '1', 10:09:35 INFO - 'NO_EM_RESTART': '1', 10:09:35 INFO - 'PAGER': '/bin/cat', 10:09:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:35 INFO - 'PWD': '/builds/slave/test', 10:09:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:35 INFO - 'SHELL': '/bin/bash', 10:09:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:35 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:35 INFO - 'USER': 'cltbld', 10:09:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:35 INFO - 'XPC_FLAGS': '0x0', 10:09:35 INFO - 'XPC_SERVICE_NAME': '0', 10:09:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:36 INFO - Downloading/unpacking psutil>=3.1.1 10:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:39 INFO - Installing collected packages: psutil 10:09:39 INFO - Running setup.py install for psutil 10:09:39 INFO - building 'psutil._psutil_osx' extension 10:09:39 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 10:09:40 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 10:09:40 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 10:09:40 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 10:09:40 INFO - building 'psutil._psutil_posix' extension 10:09:40 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 10:09:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:09:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:09:40 INFO - ^ 10:09:40 INFO - 1 warning generated. 10:09:40 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 10:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:09:40 INFO - Successfully installed psutil 10:09:40 INFO - Cleaning up... 10:09:40 INFO - Return code: 0 10:09:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:09:40 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')]} 10:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 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')]} 10:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:40 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:40 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 10:09:40 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 10:09:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:40 INFO - 'HOME': '/Users/cltbld', 10:09:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:40 INFO - 'LOGNAME': 'cltbld', 10:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:40 INFO - 'MOZ_NO_REMOTE': '1', 10:09:40 INFO - 'NO_EM_RESTART': '1', 10:09:40 INFO - 'PAGER': '/bin/cat', 10:09:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:40 INFO - 'PWD': '/builds/slave/test', 10:09:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:40 INFO - 'SHELL': '/bin/bash', 10:09:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:40 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:40 INFO - 'USER': 'cltbld', 10:09:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:40 INFO - 'XPC_FLAGS': '0x0', 10:09:40 INFO - 'XPC_SERVICE_NAME': '0', 10:09:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:09:43 INFO - Installing collected packages: mozsystemmonitor 10:09:43 INFO - Running setup.py install for mozsystemmonitor 10:09:43 INFO - Successfully installed mozsystemmonitor 10:09:43 INFO - Cleaning up... 10:09:43 INFO - Return code: 0 10:09:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:09:43 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')]} 10:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:43 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')]} 10:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:43 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:43 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 10:09:43 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 10:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:43 INFO - 'HOME': '/Users/cltbld', 10:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:43 INFO - 'LOGNAME': 'cltbld', 10:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:43 INFO - 'MOZ_NO_REMOTE': '1', 10:09:43 INFO - 'NO_EM_RESTART': '1', 10:09:43 INFO - 'PAGER': '/bin/cat', 10:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:43 INFO - 'PWD': '/builds/slave/test', 10:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:43 INFO - 'SHELL': '/bin/bash', 10:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:43 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:43 INFO - 'USER': 'cltbld', 10:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:43 INFO - 'XPC_FLAGS': '0x0', 10:09:43 INFO - 'XPC_SERVICE_NAME': '0', 10:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 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 10:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:46 INFO - warning: no files found matching '*.txt' 10:09:46 INFO - no previously-included directories found matching 'build' 10:09:46 INFO - no previously-included directories found matching 'dist' 10:09:46 INFO - no previously-included directories found matching '.git*' 10:09:46 INFO - Installing collected packages: jsonschema, functools32 10:09:46 INFO - Running setup.py install for functools32 10:09:46 INFO - warning: no files found matching '*.txt' 10:09:46 INFO - no previously-included directories found matching 'build' 10:09:46 INFO - no previously-included directories found matching 'dist' 10:09:46 INFO - no previously-included directories found matching '.git*' 10:09:46 INFO - Successfully installed jsonschema functools32 10:09:46 INFO - Cleaning up... 10:09:47 INFO - Return code: 0 10:09:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:47 INFO - 'HOME': '/Users/cltbld', 10:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:47 INFO - 'LOGNAME': 'cltbld', 10:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:47 INFO - 'MOZ_NO_REMOTE': '1', 10:09:47 INFO - 'NO_EM_RESTART': '1', 10:09:47 INFO - 'PAGER': '/bin/cat', 10:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:47 INFO - 'PWD': '/builds/slave/test', 10:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:47 INFO - 'SHELL': '/bin/bash', 10:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:47 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:47 INFO - 'USER': 'cltbld', 10:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:47 INFO - 'XPC_FLAGS': '0x0', 10:09:47 INFO - 'XPC_SERVICE_NAME': '0', 10:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:09:47 INFO - Cleaning up... 10:09:47 INFO - Return code: 0 10:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:47 INFO - 'HOME': '/Users/cltbld', 10:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:47 INFO - 'LOGNAME': 'cltbld', 10:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:47 INFO - 'MOZ_NO_REMOTE': '1', 10:09:47 INFO - 'NO_EM_RESTART': '1', 10:09:47 INFO - 'PAGER': '/bin/cat', 10:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:47 INFO - 'PWD': '/builds/slave/test', 10:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:47 INFO - 'SHELL': '/bin/bash', 10:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:47 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:47 INFO - 'USER': 'cltbld', 10:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:47 INFO - 'XPC_FLAGS': '0x0', 10:09:47 INFO - 'XPC_SERVICE_NAME': '0', 10:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:50 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 10:09:51 INFO - Downloading docopt-0.6.1.tar.gz 10:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:51 INFO - Running setup.py install for blobuploader 10:09:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:51 INFO - Running setup.py install for requests 10:09:51 INFO - Running setup.py install for docopt 10:09:52 INFO - Successfully installed blobuploader requests docopt 10:09:52 INFO - Cleaning up... 10:09:52 INFO - Return code: 0 10:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:52 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:52 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 10:09:52 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 10:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:52 INFO - 'HOME': '/Users/cltbld', 10:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:52 INFO - 'LOGNAME': 'cltbld', 10:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:52 INFO - 'MOZ_NO_REMOTE': '1', 10:09:52 INFO - 'NO_EM_RESTART': '1', 10:09:52 INFO - 'PAGER': '/bin/cat', 10:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:52 INFO - 'PWD': '/builds/slave/test', 10:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:52 INFO - 'SHELL': '/bin/bash', 10:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:52 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:52 INFO - 'USER': 'cltbld', 10:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:52 INFO - 'XPC_FLAGS': '0x0', 10:09:52 INFO - 'XPC_SERVICE_NAME': '0', 10:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zjeY8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-uuiFli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZCsAkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-XN2J8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zI_ZoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:52 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KYCf0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TnZ27F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-oBv2ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-cxSkqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-LB3xSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-PzhNCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-gmGWgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IW4qxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sQYIui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4K8381-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:53 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8GAjvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:54 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_JyqNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:54 INFO - Running setup.py install for manifestparser 10:09:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:54 INFO - Running setup.py install for mozcrash 10:09:54 INFO - Running setup.py install for mozdebug 10:09:54 INFO - Running setup.py install for mozdevice 10:09:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:54 INFO - Running setup.py install for mozfile 10:09:54 INFO - Running setup.py install for mozhttpd 10:09:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Running setup.py install for mozinfo 10:09:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Running setup.py install for mozInstall 10:09:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Running setup.py install for mozleak 10:09:55 INFO - Running setup.py install for mozlog 10:09:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Running setup.py install for moznetwork 10:09:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:55 INFO - Running setup.py install for mozprocess 10:09:55 INFO - Running setup.py install for mozprofile 10:09:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:56 INFO - Running setup.py install for mozrunner 10:09:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:56 INFO - Running setup.py install for mozscreenshot 10:09:56 INFO - Running setup.py install for moztest 10:09:56 INFO - Running setup.py install for mozversion 10:09:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:56 INFO - Cleaning up... 10:09:56 INFO - Return code: 0 10:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:56 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:09:56 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 10:09:56 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 10:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:56 INFO - 'HOME': '/Users/cltbld', 10:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:56 INFO - 'LOGNAME': 'cltbld', 10:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:56 INFO - 'MOZ_NO_REMOTE': '1', 10:09:56 INFO - 'NO_EM_RESTART': '1', 10:09:56 INFO - 'PAGER': '/bin/cat', 10:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:56 INFO - 'PWD': '/builds/slave/test', 10:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:56 INFO - 'SHELL': '/bin/bash', 10:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:09:56 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:56 INFO - 'USER': 'cltbld', 10:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:56 INFO - 'XPC_FLAGS': '0x0', 10:09:56 INFO - 'XPC_SERVICE_NAME': '0', 10:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:56 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9xtbkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-txtbGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SZBEQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Jslroo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Cob7BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IOBAHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-twrdDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5vb9sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YoviJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:57 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)) 10:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:57 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YSRYmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-F6kdDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-azl31P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZB390K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZLQqAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Vz6jq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7QAg4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:58 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)) 10:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:58 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5w2I1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:58 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)) 10:09:58 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)) 10:09:58 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)) 10:09:58 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)) 10:09:58 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)) 10:09:58 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)) 10:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:01 INFO - Downloading blessings-1.6.tar.gz 10:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:10:01 INFO - Installing collected packages: blessings 10:10:01 INFO - Running setup.py install for blessings 10:10:01 INFO - Successfully installed blessings 10:10:01 INFO - Cleaning up... 10:10:01 INFO - Return code: 0 10:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:01 INFO - Reading from file tmpfile_stdout 10:10:01 INFO - Current package versions: 10:10:01 INFO - blessings == 1.6 10:10:01 INFO - blobuploader == 1.2.4 10:10:01 INFO - docopt == 0.6.1 10:10:01 INFO - functools32 == 3.2.3-2 10:10:01 INFO - jsonschema == 2.5.1 10:10:01 INFO - manifestparser == 1.1 10:10:01 INFO - mozInstall == 1.12 10:10:01 INFO - mozcrash == 0.17 10:10:01 INFO - mozdebug == 0.1 10:10:01 INFO - mozdevice == 0.48 10:10:01 INFO - mozfile == 1.2 10:10:01 INFO - mozhttpd == 0.7 10:10:01 INFO - mozinfo == 0.9 10:10:01 INFO - mozleak == 0.1 10:10:01 INFO - mozlog == 3.3 10:10:01 INFO - moznetwork == 0.27 10:10:01 INFO - mozprocess == 0.23 10:10:01 INFO - mozprofile == 0.28 10:10:01 INFO - mozrunner == 6.12 10:10:01 INFO - mozscreenshot == 0.1 10:10:01 INFO - mozsystemmonitor == 0.3 10:10:01 INFO - moztest == 0.7 10:10:01 INFO - mozversion == 1.4 10:10:01 INFO - psutil == 3.1.1 10:10:01 INFO - requests == 1.2.3 10:10:01 INFO - wsgiref == 0.1.2 10:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:01 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:10:01 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 10:10:01 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 10:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:01 INFO - 'HOME': '/Users/cltbld', 10:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:01 INFO - 'LOGNAME': 'cltbld', 10:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:01 INFO - 'MOZ_NO_REMOTE': '1', 10:10:01 INFO - 'NO_EM_RESTART': '1', 10:10:01 INFO - 'PAGER': '/bin/cat', 10:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:01 INFO - 'PWD': '/builds/slave/test', 10:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:01 INFO - 'SHELL': '/bin/bash', 10:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:10:01 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:01 INFO - 'USER': 'cltbld', 10:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:01 INFO - 'XPC_FLAGS': '0x0', 10:10:01 INFO - 'XPC_SERVICE_NAME': '0', 10:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 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)) 10:10:02 INFO - Cleaning up... 10:10:02 INFO - Return code: 0 10:10:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:02 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 0x10127ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101310618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8399d9d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, '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.FGNhzPItHH/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.C2Akgriwk7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 10:10:02 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 10:10:02 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 10:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:02 INFO - 'HOME': '/Users/cltbld', 10:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:02 INFO - 'LOGNAME': 'cltbld', 10:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:02 INFO - 'MOZ_NO_REMOTE': '1', 10:10:02 INFO - 'NO_EM_RESTART': '1', 10:10:02 INFO - 'PAGER': '/bin/cat', 10:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:02 INFO - 'PWD': '/builds/slave/test', 10:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:02 INFO - 'SHELL': '/bin/bash', 10:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:10:02 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:02 INFO - 'USER': 'cltbld', 10:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:02 INFO - 'XPC_FLAGS': '0x0', 10:10:02 INFO - 'XPC_SERVICE_NAME': '0', 10:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:10:02 INFO - Cleaning up... 10:10:02 INFO - Return code: 0 10:10:02 INFO - Running post-action listener: _resource_record_post_action 10:10:02 INFO - Running post-action listener: _start_resource_monitoring 10:10:02 INFO - Starting resource monitoring. 10:10:02 INFO - [mozharness: 2016-08-18 17:10:02.559391Z] Finished create-virtualenv step (success) 10:10:02 INFO - [mozharness: 2016-08-18 17:10:02.560388Z] Running install step. 10:10:02 INFO - Running pre-action listener: _resource_record_pre_action 10:10:02 INFO - Running main action method: install 10:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:10:02 INFO - Reading from file tmpfile_stdout 10:10:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:10:02 INFO - Reading from file tmpfile_stdout 10:10:02 INFO - Output received: 10:10:02 INFO - Usage: mozinstall [options] installer 10:10:02 INFO - Options: 10:10:02 INFO - -h, --help show this help message and exit 10:10:02 INFO - -d DEST, --destination=DEST 10:10:02 INFO - Directory to install application into. [default: 10:10:02 INFO - "/builds/slave/test"] 10:10:02 INFO - --app=APP Application being installed. [default: firefox] 10:10:02 INFO - mkdir: /builds/slave/test/build/application 10:10:02 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'] 10:10:02 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 10:10:37 INFO - Reading from file tmpfile_stdout 10:10:37 INFO - Output received: 10:10:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:10:37 INFO - Running post-action listener: _resource_record_post_action 10:10:37 INFO - [mozharness: 2016-08-18 17:10:37.111165Z] Finished install step (success) 10:10:37 INFO - [mozharness: 2016-08-18 17:10:37.111294Z] Running run-tests step. 10:10:37 INFO - Running pre-action listener: _resource_record_pre_action 10:10:37 INFO - Running main action method: run_tests 10:10:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:10:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:10:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:10:37 INFO - 2016-08-18 10:10:37.124 screenresolution[1903:18079] starting screenresolution argv=screenresolution get 10:10:37 INFO - 2016-08-18 10:10:37.126 screenresolution[1903:18079] Display 0: 1600x1200x32@60 10:10:37 INFO - 2016-08-18 10:10:37.132 screenresolution[1904:18082] starting screenresolution argv=screenresolution list 10:10:37 INFO - Available Modes on Display 0 10:10:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:10:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:10:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:10:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:10:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:10:37 INFO - Intel Iris: 10:10:37 INFO - Chipset Model: Intel Iris 10:10:37 INFO - Type: GPU 10:10:37 INFO - Bus: Built-In 10:10:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:10:37 INFO - Vendor: Intel (0x8086) 10:10:37 INFO - Device ID: 0x0a2e 10:10:37 INFO - Revision ID: 0x0009 10:10:37 INFO - Displays: 10:10:37 INFO - Display: 10:10:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:10:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:10:37 INFO - Display Serial Number: 1600x1200 60 10:10:37 INFO - Main Display: Yes 10:10:37 INFO - Mirror: Off 10:10:37 INFO - Online: Yes 10:10:37 INFO - Rotation: Supported 10:10:37 INFO - Return code: 0 10:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:10:37 INFO - Python 2.7.3 10:10:37 INFO - Return code: 0 10:10:37 INFO - grabbing minidump binary from tooltool 10:10: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')]} 10:10:37 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 0x1011dfd30>, '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 0x100f44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011d7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:10:37 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 10:10:37 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 10:10:37 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 10:10:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:10:37 INFO - Return code: 0 10:10:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:10:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:10:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:10:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:10:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:10:37 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/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 10:10:37 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/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 10:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FGNhzPItHH/Render', 10:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:37 INFO - 'HOME': '/Users/cltbld', 10:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:37 INFO - 'LOGNAME': 'cltbld', 10:10:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:10:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:37 INFO - 'MOZ_NO_REMOTE': '1', 10:10:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:10:37 INFO - 'NO_EM_RESTART': '1', 10:10:37 INFO - 'PAGER': '/bin/cat', 10:10:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:37 INFO - 'PWD': '/builds/slave/test', 10:10:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:37 INFO - 'SHELL': '/bin/bash', 10:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C2Akgriwk7/Listeners', 10:10:37 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 10:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:37 INFO - 'USER': 'cltbld', 10:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:37 INFO - 'XPC_FLAGS': '0x0', 10:10:37 INFO - 'XPC_SERVICE_NAME': '0', 10:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:37 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/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 10:10:37 INFO - mozversion application_buildid: 20160818063655 10:10:37 INFO - mozversion application_changeset: 7db43c31bdb7b4070e2e676022d39e81003c0d4f 10:10:37 INFO - mozversion application_display_name: Nightly 10:10:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:10:37 INFO - mozversion application_name: Firefox 10:10:37 INFO - mozversion application_remotingname: firefox 10:10:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:10:37 INFO - mozversion application_vendor: Mozilla 10:10:37 INFO - mozversion application_version: 51.0a1 10:10:37 INFO - mozversion platform_buildid: 20160818063655 10:10:37 INFO - mozversion platform_changeset: 7db43c31bdb7b4070e2e676022d39e81003c0d4f 10:10:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:10:37 INFO - mozversion platform_version: 51.0a1 10:10:37 INFO - using testdate: 1471540237 10:10:37 INFO - actual date: 1471540237 10:10:37 INFO - starting webserver on 'localhost:57047' 10:10:37 INFO - SUITE-START | Running 2 tests 10:10:37 INFO - TEST-START | dromaeo_css 10:10:37 INFO - operating with platform_type : mac_ 10:10:37 INFO - Initialising browser for dromaeo_css test... 10:10:37 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp64gkT5/profile http://localhost:57047/getInfo.html) 10:10:40 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 10:10:40 INFO - PROCESS | 1914 | colorDepth:24 10:10:40 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 10:10:40 INFO - PROCESS | 1914 | __metrics 10:10:40 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 10:10:41 INFO - TEST-INFO | 1914: exit 0 10:10:41 INFO - Browser initialized. 10:10:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:10:41 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp64gkT5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:53 INFO - PROCESS | 1917 | RSS: Main: 238956544 10:10:53 INFO - PROCESS | 1917 | 10:11:43 INFO - PROCESS | 1917 | 1471540303141 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] 10:13:55 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57047/tests/dromaeo/cssquery-ext.html) 10:13:56 INFO - PROCESS | 1917 | RSS: Main: 254115840 10:13:56 INFO - PROCESS | 1917 | 10:16:58 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-ext.html (next: http://localhost:57047/tests/dromaeo/cssquery-jquery.html) 10:16:59 INFO - PROCESS | 1917 | RSS: Main: 265056256 10:16:59 INFO - PROCESS | 1917 | 10:20:01 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57047/tests/dromaeo/cssquery-mootools.html) 10:20:02 INFO - PROCESS | 1917 | RSS: Main: 270721024 10:20:02 INFO - PROCESS | 1917 | 10:23:03 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57047/tests/dromaeo/cssquery-prototype.html) 10:23:04 INFO - PROCESS | 1917 | RSS: Main: 271106048 10:23:04 INFO - PROCESS | 1917 | 10:26:07 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57047/tests/dromaeo/cssquery-yui.html) 10:26:07 INFO - PROCESS | 1917 | RSS: Main: 275922944 10:26:07 INFO - PROCESS | 1917 | 10:29:10 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:57047/tests/dromaeo/cssquery-yui.html (next: http://localhost:57047/tests/dromaeo/cssquery-dojo.html) 10:29:11 INFO - PROCESS | 1917 | RSS: Main: 278491136 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | __start_tp_report 10:29:11 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 10:29:11 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 10:29:11 INFO - PROCESS | 1917 | |i|pagename|runs| 10:29:11 INFO - PROCESS | 1917 | |0;dojo.html;2950.203445069831;3298.208429976805;3303.3972268144125;3362.293918277161;3362.983185084074;5561.193626924093;5610.438956104393;5628.296462942132;5657.773689052433;5705.5435565154685;5464.890702185954;5605.579581531391;5667.234923285355;5702.743376548055;5735.512481439083;5128.102582048145;5178.922316165261;5244.056069907415;5291.497307755757;5295.894082118355;5216.817411390583;5347.893042139155;5372.892542149155;5375.3280839895015;5399.865003374927;4225.598568136023;5120.462351453081;5164.406093299281;5226.3989641191365;5263.289455923439;4441.045175287297;5028.949710502921;5236.162214045735;5262.92105618416;5317.521423071942;4436.733795972252;4842.467328593852;5211.218317252405;5213.713245771481;5220.660657057279;5525.198846167324;5556.6943818089985;5653.491185793298;5689.374168841424;5731.713414329309;6195.101710252034;6240.594361366497;6281.685915704196;6303.023031430135;6303.905441418382;4799.352087468182;6287.8742425151695;6359.523035772336;6361.300256971729;6363.3954774296835;4630.004549021976;4783.282507623815;5246.23929530216;5883.676397798119;5896.439838215363;5407.648087978006;6163.96918015407;6240.500759939194;6257.405546473078;6284.622922624657;5831.183634291203;6181.907271390933;6197.876042479125;6199.411055949678;6213.03697926822;6122.816315510542;6155.138280640714;6176.197094377702;6190.535709821781;6198.101275315054;6000.309964354155;6114.084479019511;6199.783007594712;6203.751849926042;6212.4408803207925;6263.217097862767;6271.96864015677;6277.780277690259;6280.466160376419;6290.905636415458;4179.97910010448;4882.609391248691;5015.122353588107;5029.371328583927;5032;4370.322599997005;4423.358613001097;4442.8667139985855;4465.218586747306;4524.864254072383;5776.971115144397;5830.941690583125;5846.210761547221;5851.590388672837;5852.268466441695;6130.080487926846;6320.841978950563;6322.304546499973;6335.683215839282;6341.8097457076365;5733.8566535836935;5775.913361299584;5779.942200577941;5823.56323275756;5824.844807421281;5438.401775804658;5452.972735136378;5458.972705136449;5463.644863083887;5467.343918729778;6220.502359811295;6285.779997700059;6286.654234017173;6311.179546658905;6312.747490100436;6186.752529898754;6252.624842509464;6263.749450021948;6271.78048768291;6331.651759153291;6302.1492098566105;6304.590201636879;6311.337309582428;6318.052292156213;6318.368163183645;6074.605150665193;6227.50179985591;6268.623882567061;6272.278687950944;6287.528435367457;6162.22972128484;6185.165002724754;6199.721012554536;6264.561480696308;6275.152854364603;6048;6131.693415329305;6132.8773424532155;6140.938590614215;6157.568970172045;4839.661223714447;6100.75596976116;6165.5375846810775;6176.289726681489;6178.258608966953;5831.212786273968;5871.4715675589405;5917.615355001911;5918.319393269829;6002.369751176064;4589.541045895384;6010.54920880927;6170.475509581735;6174.722137503733;6181.690915454299;5239.842804715865;5801.94198058014;5929.258842644669;6005.429484198994;6063.211782468251 10:29:11 INFO - PROCESS | 1917 | |1;ext.html;520.8151106357245;524.3445692883895;537.8225185688723;553.7701853730704;565.5645153232014;38224.80887595562;40504.59495405045;40605.79697101518;40712.59287407125;40735;41351.379729304084;41609.16781664373;41900.16199676005;41911.16177676445;41982.7900860496;9704.369216000954;9902.554385052654;9913.058259465339;9933.75165620858;9947.20422366209;9800.166985806214;9886.011398860092;9914.107730304271;9914.454704991223;9937.403755774676;8834.807301014345;9558.426494410358;9878.308518403715;9937.652182173626;9967.700968970943;8659.653613855438;9836.31145819793;9848.556814943344;9877.209823214125;9879.753006174831;9802.705918822376;9884.851727224097;9894.604215831358;9895.505224738734;9900.90099099007;34502;39652.40521392181;39859.8007009966;40040.39939400882;40842.38736418956;2631.9605205921926;3258.332041931398;3327.517509961042;3496.248306614065;3518.982405087984;24829.5034099317;30501.847490762626;30512.84743576268;30728.846355768303;31378.52932206019;3144.9371012579622;3149.4803357445994;3161.66802485738;3166.746660267173;3239.6436391996863;458419;462319;466060;467000;467341;32768.50847237293;33001;33104.50343244853;33164.1708957278;33283.66716332806;34051.829740851135;34247.97256082322;34300.828495857364;34972.47541286883;35059;16868.409605663743;16913.238904249338;17050.74423883643;17064.573385665208;17066.317347306216;12994.350282486026;13052.869471305165;13157.210567365988;13171.209727416386;13191.934040329737;18941.621167576846;19065.332713354965;19089.61820763577;19091.522711932314;19157.904210478857;8168.387370947203;8232.588370581567;8276.048254450694;8283.83432331362;8345.329494561804;789.6407134753673;825.6912793222809;843.843888880559;941.3761261823437;992.9553170107363;23678.88160559186;30295.939642112422;30697.693023069485;31035.84482077575;31363.529547056813;1029.840374741916;1102.60857395625;1125.454154734953;1135.1486385211092;1144.2219290882113;15757.164727648113;15920.283587238602;16091.954022988468;16092;16181.514554563382;578194;595828.0834383288;685681;691253;696646;58629.70685146547;58883;58901.70549147313;59006;59158.70420647955;1299.7335546213003;1311.9475220991244;1342.3422522963872;1357.7216670582507;1397.6715471864104;27563.586546201423;29401.558976615797;30028.699713002592;30357.93747218837;30839.383212336077;50043.49956500388;50546.73633159053;50792.23811642902;50858.23712644239;50920.49079509306;605473;608146;609388;609717;611285;25167.622485662363;25330.493390131727;25387.873060634578;25602;25621.61567576525;48038;48328;49033;49090.50909491002;49203.753981229864;36528.817355914114;38302.61697382991;39031.41452878266;39068.43726250918;39473.40789888096;39183;39204.803975979936;39482.40776388414;39541.80229098836;40254.79872600736;38377.6162238374;38832.08759343117;39407;39431.408528871514;40875.7956210217;31156.688433115378;34491.827540862134;34543.4818477718;34645.13387165341;34682.47976280408;20839.8958005209;25908.740912591387;25991.610125848507;26020.8698956504;26115.738842611332 10:29:11 INFO - PROCESS | 1917 | |2;jquery.html;372.9496517970075;376.70616918803336;384.23728898137193;386.92068126034167;404.95950404959507;18747.437576872697;20754.896225518853;21034;21078.473038174016;21232.04455799489;20137.496562585944;20434.489137771565;20861.582768344622;20933.685994710093;20968.26611068613;5795.304563452391;5877.265341832271;5877.735501902424;5896.262967129109;6043.7280322385595;4067.9389809152885;5813.476787089161;5882.529397648199;6288.119663247149;6554.639494827783;6537;6578.8684226315445;6595.241547222083;6602.537822352438;6620.900686489683;6451.870962580769;6510.576812507195;6585.111010013683;6597.142371491699;6644.833879153036;5054.949450505522;5343.171808369709;5715.0855863062125;5715.1713001614535;5738.995675756726;12923.87076129236;13159.276239806806;13164.670883227996;13205.075644704875;18724.90637546817;2274.1130958925864;2337.812974962016;2367.786899179065;2376.429656882353;2388.737238903719;10175.745606359826;10197;10197.847032294521;10323.948380258125;10437.739056523647;1597.9520614381588;1857.247814635075;1883.6138591588692;1888.1975160556708;1953.2187125149912;77326;83752;103183.48408257986;118310.63378732464;129671.70328296596;11357.148213883991;11553.36456494884;11614.88385116138;11725.355105469282;11772.17594768358;14374.640633984025;14437.494687685881;14466.782998255034;14507.347169377403;14703.632409189642;7165.6775445105095;7596.430267729942;8057;8575.699850505202;8748.95625521881;8456.40805143634;8516.8722469163;8568.700095496628;8660.78748975144;8687.609057592423;3950.1309711863346;4268.253055715238;4555.2256116460285;4560.4527456704745;4619.23782575878;1570.685862827439;1657.9585510362338;1677.1614192903548;1931.6329897319465;1962.4398603110562;763.8128658478709;990.782027953849;999.81003609314;1009.8437289303853;1035.8239099353127;19818.20727170897;20836.791632083485;21082.89458552728;21162.365129046153;21387.786122138892;912.2291663544295;935.3826474526779;947.7016487412152;951.3388195204404;987.6197663899306;7997.720079797179;9704.854427183598;10962.835557466644;11076.556937722562;11122.833157502644;604509;610558;610634;624502;625823;137565;138895.97449182862;139386.303068484;140417.29791350977;141481;946.2950102173925;961.5672947173659;974.2498276327188;977.7897751983357;979.5053497983615;13795.448182072605;17161.31354745796;17740.91129544344;18595.791273567174;18611.255549778398;55576.72211638916;56665.58336041632;57132.1430178556;57280.71359643175;58304;60997;79521;81934.18065819265;82716.3456730874;83244.58377708073;7268;7270.527415717961;7389.334959853639;7547.547147171187;7634.6182690864125;10424.635137770141;11227.438628068401;13003.869961300645;13144.60566183016;13210.735785284049;11035.779284414428;11206.943965280121;11355.886441135483;11558.30650160993;11733.589324373606;9423.623055077995;10989.560417583207;11119.27724697892;11364.715882103013;11696.122790790894;11024.50389732448;11520.251183673034;11747;11755.764884702086;11796.233244839059;8050.637721302673;8159.510429374256;8239.134890836616;8382.49705017701;8418.158184181533;8796.208341249318;9794.265430092913;10821.67534973952;10826.837597436202;11296.943515282372 10:29:11 INFO - PROCESS | 1917 | |3;mootools.html;1424.9145051296923;1461.393521688499;1643.9917800410997;1682.461612284069;1883.8963856987868;7883.448158628884;8341.207585279397;8484.95757521213;8879;8892.288616910655;8502.659893604265;8677.305815534757;8684.305255579555;8725.694600688978;8747.606357713903;2318.2002209237785;2363.2555744940373;2365.4559451326204;2366.396568874943;2367.6685264063044;2334.9649755253686;2349.6358064499946;2364.6216605343147;2379.0721618568773;2383.809295256384;1843.5483306589904;2344.1443872986324;2348.5772560939026;2363.0665886974634;2369.8578085314934;1789.9373521926734;1928.238345853387;1973.6546104431739;2342.6954495915593;2360.3391050505884;1935.400025991947;1977.8219960203508;2334.8949297281665;2335.8204106926064;2350.106959355434;8672.8699069514;8817;8817.250533704642;8831.69089081879;8834.911650883538;5185.248139019859;5338.412774594792;5343.572514198893;5347.064263753867;5351.304330437058;3510.8420121094355;3569.9294409242575;3656.6891814195824;3661.505696730934;3693.7045036397026;942.7878727286375;1106.115107913674;1114.2757207814905;1120.0479592346521;1131.490829126888;11456.255343402736;11517.424128793611;11589.536418543248;11594.536218551248;11645.534178632844;4557.749323787158;4617.722936623813;4785.665003449794;4787.353707249476;4813.78337974792;9635.903640963641;9799.363041402286;9805.264605154642;9821.459819709984;9851.802963940681;5252.868678282997;5254.395744489356;5299.6025298102795;5303.018941495836;5308.23030660552;4330.17726631939;4743.905121897543;4818.7831547580445;4850.102730994778;4852.757362131879;3455.222574920673;3831.080540670275;3858.131920317906;3878.941815872764;3983.462232598562;1274.955376561816;1281.14803655568;1285.6785803549112;1288.4137717338588;1297.695041665208;768.4390395011673;914.2000749344323;923.4320892650971;937.554661535765;961.1925982175006;5391.892162156735;5599.44005599445;6025;6066.181065556093;6089.725962331706;920.3281604428671;950.8526178442353;952.8523078922778;974.3082411487782;1000.9349392289478;3408.7954722716718;3949.8025098744947;4065.6340929316502;4083.5508094109623;4178.101708132705;8763.69327073562;10540.9986051325;10591.629292974709;10750.247482676294;10766.30019048775;8557.44376615518;10665.36007839532;10704.785904282027;10714.89285107139;10720.731981700364;7843.450958432969;8142.511449312941;8156.388270879707;8187.754367368989;8195.918040819635;5856.4143585641095;5954.523638108854;5987.970060149845;6164.537659675632;6196.318404975359;9609.894862090949;9776.511174441392;9986.900130998598;9992.350497217658;9992.700218993441;9171.908280917105;9185.805845240076;9655.710328690151;10200.4389758564;10207.795844082928;6945.409640180439;7307.525010874276;7480.476366654282;7501.812454688458;7647.579383133981;7666.348360389206;7887.895694602875;8396.454230475;8472.49165050099;8484.957575212084;6170.197874276315;6232.626042437469;6696.59820410777;7475.626218689153;7602.695892164252;7396.186419493959;7405.370543503647;7438.851222975619;7448.143463501767;7536.698532058656;6072.75508520761;6854.588724676535;6894.413974812197;7009.719611215494;7050.471214658818;5035;5060.544550990428;5078.0605587964865;5096.668716533413;5128.487151284841;4947.950520494749;5043.621728370314;5089.262057001788;5204.375474943031;5214.843554693365 10:29:11 INFO - PROCESS | 1917 | |4;prototype.html;255.95264875997935;281.37394297687644;304.93291475875316;315.5755508840609;316.59317776657;4718.537253451424;5264.552513036392;5620.718964051802;5759.740811663475;5766.279215098113;4620.544528473529;5294.391145018324;5624.71876406179;5667.064934285848;5735.254416925804;4082.999665082059;4208.2845916194165;4312;4319.784010799463;4357.3899654048455;3604.4773507841346;4105.3020986432375;4301.634361079312;4342.196693611676;4343.457067866517;3489.72082233422;3906.726529142961;4321.935170972438;4359.106383191454;4368.803403846835;3473.635268296843;4110.630043296088;4216.704830661855;4339.500957389909;4373.628241599468;3710.3321402147603;3714.5855194124038;3721.3673675475234;3728.7017038636845;3736.159364143073;4474.955250447487;4527.505923045387;5522.502974732293;5540.279763630742;5561.77752889884;4802.639802014828;4916.975415122937;4928.063667903087;4977.477364876709;5015.783585071557;6000.759969601254;6025.517958563304;6036.63780173191;6058.182145410357;6066.636001839904;3339.7328213742844;4056.7971601419813;4159.417681524589;4177.874663760092;4180.832766689329;5290.576753859682;5428.941356435496;5871.324797648283;6153.230846144232;6264.561480696353;3493.9301213976087;3569.4824250483534;3636.890893273206;4164.958350416457;4216.1238248979525;4140.896477588024;4234.216669916075;4240.49114106303;4260.403543503912;4283.400323954649;4252.893677658021;4735.905281894412;4756.6670333077045;4977.626677999165;4980.377452818398;5331.067912648028;5934.13954976526;5994.850128746729;6003.459688628044;6063.454289114001;1430.5779794960304;1445.6819499710048;1449.1884544655027;1449.9637509062359;1451.8548145185398;757.9242075792376;811.4279432999721;834.9373796965252;881.5019513974584;885.7298523950257;5071.54356107952;5506.559475241971;5644.915326270109;5706.400827913092;5794.391588883106;4939.5554400104165;5724.427557244242;6034.702538954146;6229.688515574203;6296.842578935563;4801.903961920742;4997.400311962588;5385.38068122171;5611.579131565149;5704.71476426177;2618.5679362904907;3214.4053350129834;3226.2418331692033;3229.7081167532706;3243.351329734063;6008.317671052112;6307.653079080695;6355.3009168991375;6364.554481186365;6412.050456789929;5667.874547044858;6157.538184636171;6287.805316989758;6351.174347334817;6374.490040796725;5156.329677142097;5891.348892998168;6231.694273118885;6352.6801774793585;6373.553851230369;4957.231629097496;5291.60312976536;5364.624476286778;5839.284732599362;5994.490468310242;4778.402699662543;5002.924956125734;5667.659940403589;6137.539684523768;6201.782937597162;5722.281916089824;5986.311574169026;6453.806385808433;6454.967725161344;6494.805155845333;3368.4105281575135;4147.79261036953;4156.210320039183;4161.500619925629;4170.893698682146;5257.947420525746;5267.78928842842;5497.038018346853;5981.043033114681;6257.843553911189;4965.45380008206;5943.435373639497;5998.940010599838;6030.638161710136;6058.7273572688455;4887.780049897692;6128.448439640454;6132.693365331805;6132.938670613236;6150.569460137926;5373.811916582901;5860.413958604106;5881.176635271151;6013.053603734052;6062.727177277121;4735.502772208868;4878.341423907869;5778.988676981596;6025.879482410415;6083.574149809471;4654.2785868190485;5846.269216347957;5910.083936989773;5955.434233747787;5997.610155339889 10:29:11 INFO - PROCESS | 1917 | |5;yui.html;721.1598487761756;724.5725022236883;779.2674885607529;794.3605397654885;813.1015228172871;16066.036037837723;16597.41909033184;16631.584210394747;16641.001539907615;16656.833431665695;14702.926485367585;14752.114873107594;14829.110253384804;14870.182139982297;14921.552353429415;670.4066900792809;829.5022986208287;847.4745657692224;857.0615176381851;869.0874581689233;860.3031544448985;863.0463338011501;866.800635853754;868.4962721621445;871.3508436215029;919.3610440743686;920.9217216536603;921.8663293822392;922.229938001766;925.6806401791405;898.348697194532;908.2098574240387;911.8723378726984;914.8444764390069;916.5371487398854;673.3502170405582;679.1883698979722;681.0057316318181;686.6669665212368;686.8351595617016;14935.253237338198;14941.327640256215;14953.476628317956;14959.775603365959;14970.850291497054;14744.189069601167;14762.852371476256;14791.852081479155;14796.18620975846;14900.403983840633;11924.224925379822;12134.696632584168;12393.62819115419;12394.504219831197;12540.122191446602;3845.1540661054523;3853.7495062820826;4029.637332640047;4074.4703188585295;4075.8777236682945;125066.37466812698;126656.36671816674;127422;128269;128481;7945.165757595485;10019.298649094639;11215.04672102864;11270.21108522412;11674.824877626843;16389.67220655604;17027.48917532476;17107.48677539676;21641.675374869388;21696;6677.599344039373;7745.728899488604;7865.174156713577;8035.477693949874;8091.55496447701;3954.9519377365023;4471.8434854779925;4533.863984080483;4590.724556526619;4681.32120842476;2902.5210840211553;3623.6592460789147;3628.9818550907603;3636.345457817565;3637.5816781069984;591.3170288317001;620.1534904854841;647.9222493300834;654.4633400611453;668.1881513960561;509.27936969188926;510.7573902396332;583.3087790967717;596.9224000879858;618.8685252621748;8252.504849709037;8846.115388461103;9143.177114059767;9172.403793753385;9186.494742789077;551.1237132958615;591.8727473593198;613.9815805525841;623.4731651754261;646.618495087891;3490.8254587270535;4422.933655995163;4549.27211646135;5062.294428386311;5111.284420181178;165030;165218;166916;168035.31964680197;170983;137530;139291;140368;140646;141691;118533.40733296279;118853;119396;119928;121295;9774.48100761681;10215.591376344863;10228.386296822215;10295.330803497749;10304.227182961458;65956.34043659693;66488;67274.66362668155;68099.97850032154;68938;100312;103768;104113;104457;107123;12837.358132093545;13246;13599.388027538587;13861.306934653428;14058.929705351817;15188.696226075195;15226.543203703906;15326.624373222168;15937.601559961095;15978.360865565712;14000.64998375008;14086.15483071019;14169.43322267139;14760.114393136446;14870.256487175815;12669.746605067663;12928.38454880959;13064.150830196008;13169.868301316865;13311.400986955416;13822;13940.233287169303;14040;14269.286535672967;14500.854991450373;11242.83135752948;11527.88472115268;11539.769204616028;11612.6516204514;11893.821592675944;8938.46369217849;9854.901450985684;9857.654982075594;10450.32794752836;10876.619318324138 10:29:11 INFO - PROCESS | 1917 | __end_tp_report 10:29:11 INFO - PROCESS | 1917 | __start_cc_report 10:29:11 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,410 10:29:11 INFO - PROCESS | 1917 | __end_cc_report 10:29:11 INFO - PROCESS | 1917 | __startTimestamp1471541351132__endTimestamp 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | ------- Summary: start ------- 10:29:11 INFO - PROCESS | 1917 | Number of tests: 6 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5685.91 Median:5883.68 stddev:701.52 (11.9%) stddev-sans-first:670.04 10:29:11 INFO - PROCESS | 1917 | Values: 2950.2 3298.2 3303.4 3362.3 3363.0 5561.2 5610.4 5628.3 5657.8 5705.5 5464.9 5605.6 5667.2 5702.7 5735.5 5128.1 5178.9 5244.1 5291.5 5295.9 5216.8 5347.9 5372.9 5375.3 5399.9 4225.6 5120.5 5164.4 5226.4 5263.3 4441.0 5028.9 5236.2 5262.9 5317.5 4436.7 4842.5 5211.2 5213.7 5220.7 5525.2 5556.7 5653.5 5689.4 5731.7 6195.1 6240.6 6281.7 6303.0 6303.9 4799.4 6287.9 6359.5 6361.3 6363.4 4630.0 4783.3 5246.2 5883.7 5896.4 5407.6 6164.0 6240.5 6257.4 6284.6 5831.2 6181.9 6197.9 6199.4 6213.0 6122.8 6155.1 6176.2 6190.5 6198.1 6000.3 6114.1 6199.8 6203.8 6212.4 6263.2 6272.0 6277.8 6280.5 6290.9 4180.0 4882.6 5015.1 5029.4 5032.0 4370.3 4423.4 4442.9 4465.2 4524.9 5777.0 5830.9 5846.2 5851.6 5852.3 6130.1 6320.8 6322.3 6335.7 6341.8 5733.9 5775.9 5779.9 5823.6 5824.8 5438.4 5453.0 5459.0 5463.6 5467.3 6220.5 6285.8 6286.7 6311.2 6312.7 6186.8 6252.6 6263.7 6271.8 6331.7 6302.1 6304.6 6311.3 6318.1 6318.4 6074.6 6227.5 6268.6 6272.3 6287.5 6162.2 6185.2 6199.7 6264.6 6275.2 6048.0 6131.7 6132.9 6140.9 6157.6 4839.7 6100.8 6165.5 6176.3 6178.3 5831.2 5871.5 5917.6 5918.3 6002.4 4589.5 6010.5 6170.5 6174.7 6181.7 5239.8 5801.9 5929.3 6005.4 6063.2 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:69230.35 Median:39419.20 stddev:155444.22 (394.3%) stddev-sans-first:155794.67 10:29:11 INFO - PROCESS | 1917 | Values: 520.8 524.3 537.8 553.8 565.6 38224.8 40504.6 40605.8 40712.6 40735.0 41351.4 41609.2 41900.2 41911.2 41982.8 9704.4 9902.6 9913.1 9933.8 9947.2 9800.2 9886.0 9914.1 9914.5 9937.4 8834.8 9558.4 9878.3 9937.7 9967.7 8659.7 9836.3 9848.6 9877.2 9879.8 9802.7 9884.9 9894.6 9895.5 9900.9 34502.0 39652.4 39859.8 40040.4 40842.4 2632.0 3258.3 3327.5 3496.2 3519.0 24829.5 30501.8 30512.8 30728.8 31378.5 3144.9 3149.5 3161.7 3166.7 3239.6 458419.0 462319.0 466060.0 467000.0 467341.0 32768.5 33001.0 33104.5 33164.2 33283.7 34051.8 34248.0 34300.8 34972.5 35059.0 16868.4 16913.2 17050.7 17064.6 17066.3 12994.4 13052.9 13157.2 13171.2 13191.9 18941.6 19065.3 19089.6 19091.5 19157.9 8168.4 8232.6 8276.0 8283.8 8345.3 789.6 825.7 843.8 941.4 993.0 23678.9 30295.9 30697.7 31035.8 31363.5 1029.8 1102.6 1125.5 1135.1 1144.2 15757.2 15920.3 16092.0 16092.0 16181.5 578194.0 595828.1 685681.0 691253.0 696646.0 58629.7 58883.0 58901.7 59006.0 59158.7 1299.7 1311.9 1342.3 1357.7 1397.7 27563.6 29401.6 30028.7 30357.9 30839.4 50043.5 50546.7 50792.2 50858.2 50920.5 605473.0 608146.0 609388.0 609717.0 611285.0 25167.6 25330.5 25387.9 25602.0 25621.6 48038.0 48328.0 49033.0 49090.5 49203.8 36528.8 38302.6 39031.4 39068.4 39473.4 39183.0 39204.8 39482.4 39541.8 40254.8 38377.6 38832.1 39407.0 39431.4 40875.8 31156.7 34491.8 34543.5 34645.1 34682.5 20839.9 25908.7 25991.6 26020.9 26115.7 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:35123.81 Median:374.83 stddev:102663.75 (27389.6%) stddev-sans-first:102918.59 10:29:11 INFO - PROCESS | 1917 | Values: 372.9 376.7 384.2 386.9 405.0 18747.4 20754.9 21034.0 21078.5 21232.0 20137.5 20434.5 20861.6 20933.7 20968.3 5795.3 5877.3 5877.7 5896.3 6043.7 4067.9 5813.5 5882.5 6288.1 6554.6 6537.0 6578.9 6595.2 6602.5 6620.9 6451.9 6510.6 6585.1 6597.1 6644.8 5054.9 5343.2 5715.1 5715.2 5739.0 12923.9 13159.3 13164.7 13205.1 18724.9 2274.1 2337.8 2367.8 2376.4 2388.7 10175.7 10197.0 10197.8 10323.9 10437.7 1598.0 1857.2 1883.6 1888.2 1953.2 77326.0 83752.0 103183.5 118310.6 129671.7 11357.1 11553.4 11614.9 11725.4 11772.2 14374.6 14437.5 14466.8 14507.3 14703.6 7165.7 7596.4 8057.0 8575.7 8749.0 8456.4 8516.9 8568.7 8660.8 8687.6 3950.1 4268.3 4555.2 4560.5 4619.2 1570.7 1658.0 1677.2 1931.6 1962.4 763.8 990.8 999.8 1009.8 1035.8 19818.2 20836.8 21082.9 21162.4 21387.8 912.2 935.4 947.7 951.3 987.6 7997.7 9704.9 10962.8 11076.6 11122.8 604509.0 610558.0 610634.0 624502.0 625823.0 137565.0 138896.0 139386.3 140417.3 141481.0 946.3 961.6 974.2 977.8 979.5 13795.4 17161.3 17740.9 18595.8 18611.3 55576.7 56665.6 57132.1 57280.7 58304.0 60997.0 79521.0 81934.2 82716.3 83244.6 7268.0 7270.5 7389.3 7547.5 7634.6 10424.6 11227.4 13003.9 13144.6 13210.7 11035.8 11206.9 11355.9 11558.3 11733.6 9423.6 10989.6 11119.3 11364.7 11696.1 11024.5 11520.3 11747.0 11755.8 11796.2 8050.6 8159.5 8239.1 8382.5 8418.2 8796.2 9794.3 10821.7 10826.8 11296.9 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5629.22 Median:5233.86 stddev:3136.14 (59.9%) stddev-sans-first:3129.02 10:29:11 INFO - PROCESS | 1917 | Values: 1424.9 1461.4 1644.0 1682.5 1883.9 7883.4 8341.2 8485.0 8879.0 8892.3 8502.7 8677.3 8684.3 8725.7 8747.6 2318.2 2363.3 2365.5 2366.4 2367.7 2335.0 2349.6 2364.6 2379.1 2383.8 1843.5 2344.1 2348.6 2363.1 2369.9 1789.9 1928.2 1973.7 2342.7 2360.3 1935.4 1977.8 2334.9 2335.8 2350.1 8672.9 8817.0 8817.3 8831.7 8834.9 5185.2 5338.4 5343.6 5347.1 5351.3 3510.8 3569.9 3656.7 3661.5 3693.7 942.8 1106.1 1114.3 1120.0 1131.5 11456.3 11517.4 11589.5 11594.5 11645.5 4557.7 4617.7 4785.7 4787.4 4813.8 9635.9 9799.4 9805.3 9821.5 9851.8 5252.9 5254.4 5299.6 5303.0 5308.2 4330.2 4743.9 4818.8 4850.1 4852.8 3455.2 3831.1 3858.1 3878.9 3983.5 1275.0 1281.1 1285.7 1288.4 1297.7 768.4 914.2 923.4 937.6 961.2 5391.9 5599.4 6025.0 6066.2 6089.7 920.3 950.9 952.9 974.3 1000.9 3408.8 3949.8 4065.6 4083.6 4178.1 8763.7 10541.0 10591.6 10750.2 10766.3 8557.4 10665.4 10704.8 10714.9 10720.7 7843.5 8142.5 8156.4 8187.8 8195.9 5856.4 5954.5 5988.0 6164.5 6196.3 9609.9 9776.5 9986.9 9992.4 9992.7 9171.9 9185.8 9655.7 10200.4 10207.8 6945.4 7307.5 7480.5 7501.8 7647.6 7666.3 7887.9 8396.5 8472.5 8485.0 6170.2 6232.6 6696.6 7475.6 7602.7 7396.2 7405.4 7438.9 7448.1 7536.7 6072.8 6854.6 6894.4 7009.7 7050.5 5035.0 5060.5 5078.1 5096.7 5128.5 4948.0 5043.6 5089.3 5204.4 5214.8 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4780.67 Median:5291.09 stddev:1494.85 (28.3%) stddev-sans-first:1459.95 10:29:11 INFO - PROCESS | 1917 | Values: 256.0 281.4 304.9 315.6 316.6 4718.5 5264.6 5620.7 5759.7 5766.3 4620.5 5294.4 5624.7 5667.1 5735.3 4083.0 4208.3 4312.0 4319.8 4357.4 3604.5 4105.3 4301.6 4342.2 4343.5 3489.7 3906.7 4321.9 4359.1 4368.8 3473.6 4110.6 4216.7 4339.5 4373.6 3710.3 3714.6 3721.4 3728.7 3736.2 4475.0 4527.5 5522.5 5540.3 5561.8 4802.6 4917.0 4928.1 4977.5 5015.8 6000.8 6025.5 6036.6 6058.2 6066.6 3339.7 4056.8 4159.4 4177.9 4180.8 5290.6 5428.9 5871.3 6153.2 6264.6 3493.9 3569.5 3636.9 4165.0 4216.1 4140.9 4234.2 4240.5 4260.4 4283.4 4252.9 4735.9 4756.7 4977.6 4980.4 5331.1 5934.1 5994.9 6003.5 6063.5 1430.6 1445.7 1449.2 1450.0 1451.9 757.9 811.4 834.9 881.5 885.7 5071.5 5506.6 5644.9 5706.4 5794.4 4939.6 5724.4 6034.7 6229.7 6296.8 4801.9 4997.4 5385.4 5611.6 5704.7 2618.6 3214.4 3226.2 3229.7 3243.4 6008.3 6307.7 6355.3 6364.6 6412.1 5667.9 6157.5 6287.8 6351.2 6374.5 5156.3 5891.3 6231.7 6352.7 6373.6 4957.2 5291.6 5364.6 5839.3 5994.5 4778.4 5002.9 5667.7 6137.5 6201.8 5722.3 5986.3 6453.8 6455.0 6494.8 3368.4 4147.8 4156.2 4161.5 4170.9 5257.9 5267.8 5497.0 5981.0 6257.8 4965.5 5943.4 5998.9 6030.6 6058.7 4887.8 6128.4 6132.7 6132.9 6150.6 5373.8 5860.4 5881.2 6013.1 6062.7 4735.5 4878.3 5779.0 6025.9 6083.6 4654.3 5846.3 5910.1 5955.4 5997.6 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:26941.32 Median:94005.24 stddev:44330.28 (47.2%) stddev-sans-first:44410.93 10:29:11 INFO - PROCESS | 1917 | Values: 721.2 724.6 779.3 794.4 813.1 16066.0 16597.4 16631.6 16641.0 16656.8 14702.9 14752.1 14829.1 14870.2 14921.6 670.4 829.5 847.5 857.1 869.1 860.3 863.0 866.8 868.5 871.4 919.4 920.9 921.9 922.2 925.7 898.3 908.2 911.9 914.8 916.5 673.4 679.2 681.0 686.7 686.8 14935.3 14941.3 14953.5 14959.8 14970.9 14744.2 14762.9 14791.9 14796.2 14900.4 11924.2 12134.7 12393.6 12394.5 12540.1 3845.2 3853.7 4029.6 4074.5 4075.9 125066.4 126656.4 127422.0 128269.0 128481.0 7945.2 10019.3 11215.0 11270.2 11674.8 16389.7 17027.5 17107.5 21641.7 21696.0 6677.6 7745.7 7865.2 8035.5 8091.6 3955.0 4471.8 4533.9 4590.7 4681.3 2902.5 3623.7 3629.0 3636.3 3637.6 591.3 620.2 647.9 654.5 668.2 509.3 510.8 583.3 596.9 618.9 8252.5 8846.1 9143.2 9172.4 9186.5 551.1 591.9 614.0 623.5 646.6 3490.8 4422.9 4549.3 5062.3 5111.3 165030.0 165218.0 166916.0 168035.3 170983.0 137530.0 139291.0 140368.0 140646.0 141691.0 118533.4 118853.0 119396.0 119928.0 121295.0 9774.5 10215.6 10228.4 10295.3 10304.2 65956.3 66488.0 67274.7 68100.0 68938.0 100312.0 103768.0 104113.0 104457.0 107123.0 12837.4 13246.0 13599.4 13861.3 14058.9 15188.7 15226.5 15326.6 15937.6 15978.4 14000.6 14086.2 14169.4 14760.1 14870.3 12669.7 12928.4 13064.2 13169.9 13311.4 13822.0 13940.2 14040.0 14269.3 14500.9 11242.8 11527.9 11539.8 11612.7 11893.8 8938.5 9854.9 9857.7 10450.3 10876.6 10:29:11 INFO - PROCESS | 1917 | -------- Summary: end -------- 10:29:11 INFO - PROCESS | 1917 | 10:29:11 INFO - TEST-INFO | 1917: exit 0 10:29:11 INFO - TEST-OK | dromaeo_css | took 1114017ms 10:29:11 INFO - TEST-START | kraken 10:29:11 INFO - operating with platform_type : mac_ 10:29:11 INFO - Initialising browser for kraken test... 10:29:11 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpAH9dRF/profile http://localhost:57047/getInfo.html) 10:29:14 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 10:29:14 INFO - PROCESS | 1922 | colorDepth:24 10:29:14 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 10:29:14 INFO - PROCESS | 1922 | __metrics 10:29:14 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 10:29:15 INFO - TEST-INFO | 1922: exit 0 10:29:15 INFO - Browser initialized. 10:29:15 INFO - Running cycle 1/1 for kraken test... 10:29:15 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpAH9dRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:27 INFO - PROCESS | 1924 | RSS: Main: 239620096 10:29:27 INFO - PROCESS | 1924 | 10:29:30 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57047/tests/kraken/driver.html?testName=audio-beat-detection) 10:29:31 INFO - PROCESS | 1924 | RSS: Main: 252162048 10:29:31 INFO - PROCESS | 1924 | 10:29:33 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57047/tests/kraken/driver.html?testName=audio-dft) 10:29:34 INFO - PROCESS | 1924 | RSS: Main: 260829184 10:29:34 INFO - PROCESS | 1924 | 10:29:37 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57047/tests/kraken/driver.html?testName=audio-fft) 10:29:38 INFO - PROCESS | 1924 | RSS: Main: 263860224 10:29:38 INFO - PROCESS | 1924 | 10:29:40 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57047/tests/kraken/driver.html?testName=audio-oscillator) 10:29:41 INFO - PROCESS | 1924 | RSS: Main: 265158656 10:29:41 INFO - PROCESS | 1924 | 10:29:43 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:29:43 INFO - PROCESS | 1924 | RSS: Main: 265502720 10:29:43 INFO - PROCESS | 1924 | 10:29:46 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57047/tests/kraken/driver.html?testName=imaging-darkroom) 10:29:47 INFO - PROCESS | 1924 | RSS: Main: 266883072 10:29:47 INFO - PROCESS | 1924 | 10:29:50 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57047/tests/kraken/driver.html?testName=imaging-desaturate) 10:29:51 INFO - PROCESS | 1924 | RSS: Main: 267120640 10:29:51 INFO - PROCESS | 1924 | 10:29:54 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57047/tests/kraken/driver.html?testName=json-parse-financial) 10:29:54 INFO - PROCESS | 1924 | RSS: Main: 267214848 10:29:54 INFO - PROCESS | 1924 | 10:29:56 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:29:56 INFO - PROCESS | 1924 | RSS: Main: 267227136 10:29:56 INFO - PROCESS | 1924 | 10:29:58 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:59 INFO - PROCESS | 1924 | RSS: Main: 267468800 10:29:59 INFO - PROCESS | 1924 | 10:30:01 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:02 INFO - PROCESS | 1924 | RSS: Main: 267591680 10:30:02 INFO - PROCESS | 1924 | 10:30:05 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:06 INFO - PROCESS | 1924 | RSS: Main: 267468800 10:30:06 INFO - PROCESS | 1924 | 10:30:09 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:30:09 INFO - PROCESS | 1924 | RSS: Main: 267575296 10:30:09 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:57047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57047/tests/kraken/driver.html?testName=ai-astar) 10:30:11 INFO - PROCESS | 1924 | RSS: Main: 268705792 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | __start_tp_report 10:30:11 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 10:30:11 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 10:30:11 INFO - PROCESS | 1924 | |i|pagename|runs| 10:30:11 INFO - PROCESS | 1924 | |0;ai-astar;152;93;159;101;109;125;173;170;130;118 10:30:11 INFO - PROCESS | 1924 | |1;audio-beat-detection;143;112;139;162;112;133;130;114;160;119 10:30:11 INFO - PROCESS | 1924 | |2;audio-dft;206;231;199;206;203;201;198;205;218;197 10:30:11 INFO - PROCESS | 1924 | |3;audio-fft;74;85;77;151;61;60;61;65;145;59 10:30:11 INFO - PROCESS | 1924 | |4;audio-oscillator;67;72;119;93;102;61;132;102;103;152 10:30:11 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;83;132;121;87;100;115;90;85;89;87 10:30:11 INFO - PROCESS | 1924 | |6;imaging-darkroom;94;95;95;96;134;150;107;96;95;133 10:30:11 INFO - PROCESS | 1924 | |7;imaging-desaturate;111;92;91;90;91;90;92;101;92;153 10:30:11 INFO - PROCESS | 1924 | |8;json-parse-financial;56;55;62;55;57;60;56;56;57;59 10:30:11 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;65;71;65;71;68;75;74;64;103;103 10:30:11 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;90;92;95;88;86;88;93;88;89;86 10:30:11 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;140;139;148;135;147;154;166;157;164;153 10:30:11 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;170;199;156;240;237;173;176;174;173;171 10:30:11 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;67;71;68;68;70;66;68;68;70;71 10:30:11 INFO - PROCESS | 1924 | __end_tp_report 10:30:11 INFO - PROCESS | 1924 | __start_cc_report 10:30:11 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,1087 10:30:11 INFO - PROCESS | 1924 | __end_cc_report 10:30:11 INFO - PROCESS | 1924 | __startTimestamp1471541411687__endTimestamp 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | ------- Summary: start ------- 10:30:11 INFO - PROCESS | 1924 | Number of tests: 14 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:133.00 Median:155.50 stddev:28.88 (18.6%) stddev-sans-first:29.80 10:30:11 INFO - PROCESS | 1924 | Values: 152.0 93.0 159.0 101.0 109.0 125.0 173.0 170.0 130.0 118.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:136.00 stddev:18.71 (13.8%) stddev-sans-first:19.45 10:30:11 INFO - PROCESS | 1924 | Values: 143.0 112.0 139.0 162.0 112.0 133.0 130.0 114.0 160.0 119.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:206.40 Median:205.50 stddev:10.52 (5.1%) stddev-sans-first:11.16 10:30:11 INFO - PROCESS | 1924 | Values: 206.0 231.0 199.0 206.0 203.0 201.0 198.0 205.0 218.0 197.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:83.80 Median:63.00 stddev:34.93 (55.4%) stddev-sans-first:36.87 10:30:11 INFO - PROCESS | 1924 | Values: 74.0 85.0 77.0 151.0 61.0 60.0 61.0 65.0 145.0 59.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:106.50 stddev:28.96 (27.2%) stddev-sans-first:28.10 10:30:11 INFO - PROCESS | 1924 | Values: 67.0 72.0 119.0 93.0 102.0 61.0 132.0 102.0 103.0 152.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:86.00 stddev:17.48 (20.3%) stddev-sans-first:17.57 10:30:11 INFO - PROCESS | 1924 | Values: 83.0 132.0 121.0 87.0 100.0 115.0 90.0 85.0 89.0 87.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:109.50 Median:95.00 stddev:21.17 (22.3%) stddev-sans-first:21.70 10:30:11 INFO - PROCESS | 1924 | Values: 94.0 95.0 95.0 96.0 134.0 150.0 107.0 96.0 95.0 133.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:91.00 stddev:19.68 (21.6%) stddev-sans-first:20.48 10:30:11 INFO - PROCESS | 1924 | Values: 111.0 92.0 91.0 90.0 91.0 90.0 92.0 101.0 92.0 153.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.31 (4.1%) stddev-sans-first:2.40 10:30:11 INFO - PROCESS | 1924 | Values: 56.0 55.0 62.0 55.0 57.0 60.0 56.0 56.0 57.0 59.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:69.50 stddev:14.77 (21.2%) stddev-sans-first:15.13 10:30:11 INFO - PROCESS | 1924 | Values: 65.0 71.0 65.0 71.0 68.0 75.0 74.0 64.0 103.0 103.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:89.50 stddev:2.99 (3.3%) stddev-sans-first:3.17 10:30:11 INFO - PROCESS | 1924 | Values: 90.0 92.0 95.0 88.0 86.0 88.0 93.0 88.0 89.0 86.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:153.50 stddev:10.46 (6.8%) stddev-sans-first:10.41 10:30:11 INFO - PROCESS | 1924 | Values: 140.0 139.0 148.0 135.0 147.0 154.0 166.0 157.0 164.0 153.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:175.00 stddev:29.14 (16.6%) stddev-sans-first:30.26 10:30:11 INFO - PROCESS | 1924 | Values: 170.0 199.0 156.0 240.0 237.0 173.0 176.0 174.0 173.0 171.0 10:30:11 INFO - PROCESS | 1924 | 10:30:11 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.69 10:30:11 INFO - PROCESS | 1924 | Values: 67.0 71.0 68.0 68.0 70.0 66.0 68.0 68.0 70.0 71.0 10:30:11 INFO - PROCESS | 1924 | -------- Summary: end -------- 10:30:11 INFO - PROCESS | 1924 | 10:30:12 INFO - TEST-INFO | 1924: exit 0 10:30:12 INFO - TEST-OK | kraken | took 60791ms 10:30:12 INFO - SUITE-END | took 1174s 10:30:12 INFO - Completed test suite (00:19:35) 10:30:12 INFO - javascript benchmark 10:30:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7364.411794941989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2950.203445069831, 3298.208429976805, 3303.3972268144125, 3362.293918277161, 3362.983185084074, 5561.193626924093, 5610.438956104393, 5628.296462942132, 5657.773689052433, 5705.5435565154685, 5464.890702185954, 5605.579581531391, 5667.234923285355, 5702.743376548055, 5735.512481439083, 5128.102582048145, 5178.922316165261, 5244.056069907415, 5291.497307755757, 5295.894082118355, 5216.817411390583, 5347.893042139155, 5372.892542149155, 5375.3280839895015, 5399.865003374927, 4225.598568136023, 5120.462351453081, 5164.406093299281, 5226.3989641191365, 5263.289455923439, 4441.045175287297, 5028.949710502921, 5236.162214045735, 5262.92105618416, 5317.521423071942, 4436.733795972252, 4842.467328593852, 5211.218317252405, 5213.713245771481, 5220.660657057279, 5525.198846167324, 5556.6943818089985, 5653.491185793298, 5689.374168841424, 5731.713414329309, 6195.101710252034, 6240.594361366497, 6281.685915704196, 6303.023031430135, 6303.905441418382, 4799.352087468182, 6287.8742425151695, 6359.523035772336, 6361.300256971729, 6363.3954774296835, 4630.004549021976, 4783.282507623815, 5246.23929530216, 5883.676397798119, 5896.439838215363, 5407.648087978006, 6163.96918015407, 6240.500759939194, 6257.405546473078, 6284.622922624657, 5831.183634291203, 6181.907271390933, 6197.876042479125, 6199.411055949678, 6213.03697926822, 6122.816315510542, 6155.138280640714, 6176.197094377702, 6190.535709821781, 6198.101275315054, 6000.309964354155, 6114.084479019511, 6199.783007594712, 6203.751849926042, 6212.4408803207925, 6263.217097862767, 6271.96864015677, 6277.780277690259, 6280.466160376419, 6290.905636415458, 4179.97910010448, 4882.609391248691, 5015.122353588107, 5029.371328583927, 5032.0, 4370.322599997005, 4423.358613001097, 4442.8667139985855, 4465.218586747306, 4524.864254072383, 5776.971115144397, 5830.941690583125, 5846.210761547221, 5851.590388672837, 5852.268466441695, 6130.080487926846, 6320.841978950563, 6322.304546499973, 6335.683215839282, 6341.8097457076365, 5733.8566535836935, 5775.913361299584, 5779.942200577941, 5823.56323275756, 5824.844807421281, 5438.401775804658, 5452.972735136378, 5458.972705136449, 5463.644863083887, 5467.343918729778, 6220.502359811295, 6285.779997700059, 6286.654234017173, 6311.179546658905, 6312.747490100436, 6186.752529898754, 6252.624842509464, 6263.749450021948, 6271.78048768291, 6331.651759153291, 6302.1492098566105, 6304.590201636879, 6311.337309582428, 6318.052292156213, 6318.368163183645, 6074.605150665193, 6227.50179985591, 6268.623882567061, 6272.278687950944, 6287.528435367457, 6162.22972128484, 6185.165002724754, 6199.721012554536, 6264.561480696308, 6275.152854364603, 6048.0, 6131.693415329305, 6132.8773424532155, 6140.938590614215, 6157.568970172045, 4839.661223714447, 6100.75596976116, 6165.5375846810775, 6176.289726681489, 6178.258608966953, 5831.212786273968, 5871.4715675589405, 5917.615355001911, 5918.319393269829, 6002.369751176064, 4589.541045895384, 6010.54920880927, 6170.475509581735, 6174.722137503733, 6181.690915454299, 5239.842804715865, 5801.94198058014, 5929.258842644669, 6005.429484198994, 6063.211782468251], "value": 5641.2578881551035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.8151106357245, 524.3445692883895, 537.8225185688723, 553.7701853730704, 565.5645153232014, 38224.80887595562, 40504.59495405045, 40605.79697101518, 40712.59287407125, 40735.0, 41351.379729304084, 41609.16781664373, 41900.16199676005, 41911.16177676445, 41982.7900860496, 9704.369216000954, 9902.554385052654, 9913.058259465339, 9933.75165620858, 9947.20422366209, 9800.166985806214, 9886.011398860092, 9914.107730304271, 9914.454704991223, 9937.403755774676, 8834.807301014345, 9558.426494410358, 9878.308518403715, 9937.652182173626, 9967.700968970943, 8659.653613855438, 9836.31145819793, 9848.556814943344, 9877.209823214125, 9879.753006174831, 9802.705918822376, 9884.851727224097, 9894.604215831358, 9895.505224738734, 9900.90099099007, 34502.0, 39652.40521392181, 39859.8007009966, 40040.39939400882, 40842.38736418956, 2631.9605205921926, 3258.332041931398, 3327.517509961042, 3496.248306614065, 3518.982405087984, 24829.5034099317, 30501.847490762626, 30512.84743576268, 30728.846355768303, 31378.52932206019, 3144.9371012579622, 3149.4803357445994, 3161.66802485738, 3166.746660267173, 3239.6436391996863, 458419.0, 462319.0, 466060.0, 467000.0, 467341.0, 32768.50847237293, 33001.0, 33104.50343244853, 33164.1708957278, 33283.66716332806, 34051.829740851135, 34247.97256082322, 34300.828495857364, 34972.47541286883, 35059.0, 16868.409605663743, 16913.238904249338, 17050.74423883643, 17064.573385665208, 17066.317347306216, 12994.350282486026, 13052.869471305165, 13157.210567365988, 13171.209727416386, 13191.934040329737, 18941.621167576846, 19065.332713354965, 19089.61820763577, 19091.522711932314, 19157.904210478857, 8168.387370947203, 8232.588370581567, 8276.048254450694, 8283.83432331362, 8345.329494561804, 789.6407134753673, 825.6912793222809, 843.843888880559, 941.3761261823437, 992.9553170107363, 23678.88160559186, 30295.939642112422, 30697.693023069485, 31035.84482077575, 31363.529547056813, 1029.840374741916, 1102.60857395625, 1125.454154734953, 1135.1486385211092, 1144.2219290882113, 15757.164727648113, 15920.283587238602, 16091.954022988468, 16092.0, 16181.514554563382, 578194.0, 595828.0834383288, 685681.0, 691253.0, 696646.0, 58629.70685146547, 58883.0, 58901.70549147313, 59006.0, 59158.70420647955, 1299.7335546213003, 1311.9475220991244, 1342.3422522963872, 1357.7216670582507, 1397.6715471864104, 27563.586546201423, 29401.558976615797, 30028.699713002592, 30357.93747218837, 30839.383212336077, 50043.49956500388, 50546.73633159053, 50792.23811642902, 50858.23712644239, 50920.49079509306, 605473.0, 608146.0, 609388.0, 609717.0, 611285.0, 25167.622485662363, 25330.493390131727, 25387.873060634578, 25602.0, 25621.61567576525, 48038.0, 48328.0, 49033.0, 49090.50909491002, 49203.753981229864, 36528.817355914114, 38302.61697382991, 39031.41452878266, 39068.43726250918, 39473.40789888096, 39183.0, 39204.803975979936, 39482.40776388414, 39541.80229098836, 40254.79872600736, 38377.6162238374, 38832.08759343117, 39407.0, 39431.408528871514, 40875.7956210217, 31156.688433115378, 34491.827540862134, 34543.4818477718, 34645.13387165341, 34682.47976280408, 20839.8958005209, 25908.740912591387, 25991.610125848507, 26020.8698956504, 26115.738842611332], "value": 19431.265855572878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9496517970075, 376.70616918803336, 384.23728898137193, 386.92068126034167, 404.95950404959507, 18747.437576872697, 20754.896225518853, 21034.0, 21078.473038174016, 21232.04455799489, 20137.496562585944, 20434.489137771565, 20861.582768344622, 20933.685994710093, 20968.26611068613, 5795.304563452391, 5877.265341832271, 5877.735501902424, 5896.262967129109, 6043.7280322385595, 4067.9389809152885, 5813.476787089161, 5882.529397648199, 6288.119663247149, 6554.639494827783, 6537.0, 6578.8684226315445, 6595.241547222083, 6602.537822352438, 6620.900686489683, 6451.870962580769, 6510.576812507195, 6585.111010013683, 6597.142371491699, 6644.833879153036, 5054.949450505522, 5343.171808369709, 5715.0855863062125, 5715.1713001614535, 5738.995675756726, 12923.87076129236, 13159.276239806806, 13164.670883227996, 13205.075644704875, 18724.90637546817, 2274.1130958925864, 2337.812974962016, 2367.786899179065, 2376.429656882353, 2388.737238903719, 10175.745606359826, 10197.0, 10197.847032294521, 10323.948380258125, 10437.739056523647, 1597.9520614381588, 1857.247814635075, 1883.6138591588692, 1888.1975160556708, 1953.2187125149912, 77326.0, 83752.0, 103183.48408257986, 118310.63378732464, 129671.70328296596, 11357.148213883991, 11553.36456494884, 11614.88385116138, 11725.355105469282, 11772.17594768358, 14374.640633984025, 14437.494687685881, 14466.782998255034, 14507.347169377403, 14703.632409189642, 7165.6775445105095, 7596.430267729942, 8057.0, 8575.699850505202, 8748.95625521881, 8456.40805143634, 8516.8722469163, 8568.700095496628, 8660.78748975144, 8687.609057592423, 3950.1309711863346, 4268.253055715238, 4555.2256116460285, 4560.4527456704745, 4619.23782575878, 1570.685862827439, 1657.9585510362338, 1677.1614192903548, 1931.6329897319465, 1962.4398603110562, 763.8128658478709, 990.782027953849, 999.81003609314, 1009.8437289303853, 1035.8239099353127, 19818.20727170897, 20836.791632083485, 21082.89458552728, 21162.365129046153, 21387.786122138892, 912.2291663544295, 935.3826474526779, 947.7016487412152, 951.3388195204404, 987.6197663899306, 7997.720079797179, 9704.854427183598, 10962.835557466644, 11076.556937722562, 11122.833157502644, 604509.0, 610558.0, 610634.0, 624502.0, 625823.0, 137565.0, 138895.97449182862, 139386.303068484, 140417.29791350977, 141481.0, 946.2950102173925, 961.5672947173659, 974.2498276327188, 977.7897751983357, 979.5053497983615, 13795.448182072605, 17161.31354745796, 17740.91129544344, 18595.791273567174, 18611.255549778398, 55576.72211638916, 56665.58336041632, 57132.1430178556, 57280.71359643175, 58304.0, 60997.0, 79521.0, 81934.18065819265, 82716.3456730874, 83244.58377708073, 7268.0, 7270.527415717961, 7389.334959853639, 7547.547147171187, 7634.6182690864125, 10424.635137770141, 11227.438628068401, 13003.869961300645, 13144.60566183016, 13210.735785284049, 11035.779284414428, 11206.943965280121, 11355.886441135483, 11558.30650160993, 11733.589324373606, 9423.623055077995, 10989.560417583207, 11119.27724697892, 11364.715882103013, 11696.122790790894, 11024.50389732448, 11520.251183673034, 11747.0, 11755.764884702086, 11796.233244839059, 8050.637721302673, 8159.510429374256, 8239.134890836616, 8382.49705017701, 8418.158184181533, 8796.208341249318, 9794.265430092913, 10821.67534973952, 10826.837597436202, 11296.943515282372], "value": 9388.84944646601, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.9145051296923, 1461.393521688499, 1643.9917800410997, 1682.461612284069, 1883.8963856987868, 7883.448158628884, 8341.207585279397, 8484.95757521213, 8879.0, 8892.288616910655, 8502.659893604265, 8677.305815534757, 8684.305255579555, 8725.694600688978, 8747.606357713903, 2318.2002209237785, 2363.2555744940373, 2365.4559451326204, 2366.396568874943, 2367.6685264063044, 2334.9649755253686, 2349.6358064499946, 2364.6216605343147, 2379.0721618568773, 2383.809295256384, 1843.5483306589904, 2344.1443872986324, 2348.5772560939026, 2363.0665886974634, 2369.8578085314934, 1789.9373521926734, 1928.238345853387, 1973.6546104431739, 2342.6954495915593, 2360.3391050505884, 1935.400025991947, 1977.8219960203508, 2334.8949297281665, 2335.8204106926064, 2350.106959355434, 8672.8699069514, 8817.0, 8817.250533704642, 8831.69089081879, 8834.911650883538, 5185.248139019859, 5338.412774594792, 5343.572514198893, 5347.064263753867, 5351.304330437058, 3510.8420121094355, 3569.9294409242575, 3656.6891814195824, 3661.505696730934, 3693.7045036397026, 942.7878727286375, 1106.115107913674, 1114.2757207814905, 1120.0479592346521, 1131.490829126888, 11456.255343402736, 11517.424128793611, 11589.536418543248, 11594.536218551248, 11645.534178632844, 4557.749323787158, 4617.722936623813, 4785.665003449794, 4787.353707249476, 4813.78337974792, 9635.903640963641, 9799.363041402286, 9805.264605154642, 9821.459819709984, 9851.802963940681, 5252.868678282997, 5254.395744489356, 5299.6025298102795, 5303.018941495836, 5308.23030660552, 4330.17726631939, 4743.905121897543, 4818.7831547580445, 4850.102730994778, 4852.757362131879, 3455.222574920673, 3831.080540670275, 3858.131920317906, 3878.941815872764, 3983.462232598562, 1274.955376561816, 1281.14803655568, 1285.6785803549112, 1288.4137717338588, 1297.695041665208, 768.4390395011673, 914.2000749344323, 923.4320892650971, 937.554661535765, 961.1925982175006, 5391.892162156735, 5599.44005599445, 6025.0, 6066.181065556093, 6089.725962331706, 920.3281604428671, 950.8526178442353, 952.8523078922778, 974.3082411487782, 1000.9349392289478, 3408.7954722716718, 3949.8025098744947, 4065.6340929316502, 4083.5508094109623, 4178.101708132705, 8763.69327073562, 10540.9986051325, 10591.629292974709, 10750.247482676294, 10766.30019048775, 8557.44376615518, 10665.36007839532, 10704.785904282027, 10714.89285107139, 10720.731981700364, 7843.450958432969, 8142.511449312941, 8156.388270879707, 8187.754367368989, 8195.918040819635, 5856.4143585641095, 5954.523638108854, 5987.970060149845, 6164.537659675632, 6196.318404975359, 9609.894862090949, 9776.511174441392, 9986.900130998598, 9992.350497217658, 9992.700218993441, 9171.908280917105, 9185.805845240076, 9655.710328690151, 10200.4389758564, 10207.795844082928, 6945.409640180439, 7307.525010874276, 7480.476366654282, 7501.812454688458, 7647.579383133981, 7666.348360389206, 7887.895694602875, 8396.454230475, 8472.49165050099, 8484.957575212084, 6170.197874276315, 6232.626042437469, 6696.59820410777, 7475.626218689153, 7602.695892164252, 7396.186419493959, 7405.370543503647, 7438.851222975619, 7448.143463501767, 7536.698532058656, 6072.75508520761, 6854.588724676535, 6894.413974812197, 7009.719611215494, 7050.471214658818, 5035.0, 5060.544550990428, 5078.0605587964865, 5096.668716533413, 5128.487151284841, 4947.950520494749, 5043.621728370314, 5089.262057001788, 5204.375474943031, 5214.843554693365], "value": 4533.72306190115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.95264875997935, 281.37394297687644, 304.93291475875316, 315.5755508840609, 316.59317776657, 4718.537253451424, 5264.552513036392, 5620.718964051802, 5759.740811663475, 5766.279215098113, 4620.544528473529, 5294.391145018324, 5624.71876406179, 5667.064934285848, 5735.254416925804, 4082.999665082059, 4208.2845916194165, 4312.0, 4319.784010799463, 4357.3899654048455, 3604.4773507841346, 4105.3020986432375, 4301.634361079312, 4342.196693611676, 4343.457067866517, 3489.72082233422, 3906.726529142961, 4321.935170972438, 4359.106383191454, 4368.803403846835, 3473.635268296843, 4110.630043296088, 4216.704830661855, 4339.500957389909, 4373.628241599468, 3710.3321402147603, 3714.5855194124038, 3721.3673675475234, 3728.7017038636845, 3736.159364143073, 4474.955250447487, 4527.505923045387, 5522.502974732293, 5540.279763630742, 5561.77752889884, 4802.639802014828, 4916.975415122937, 4928.063667903087, 4977.477364876709, 5015.783585071557, 6000.759969601254, 6025.517958563304, 6036.63780173191, 6058.182145410357, 6066.636001839904, 3339.7328213742844, 4056.7971601419813, 4159.417681524589, 4177.874663760092, 4180.832766689329, 5290.576753859682, 5428.941356435496, 5871.324797648283, 6153.230846144232, 6264.561480696353, 3493.9301213976087, 3569.4824250483534, 3636.890893273206, 4164.958350416457, 4216.1238248979525, 4140.896477588024, 4234.216669916075, 4240.49114106303, 4260.403543503912, 4283.400323954649, 4252.893677658021, 4735.905281894412, 4756.6670333077045, 4977.626677999165, 4980.377452818398, 5331.067912648028, 5934.13954976526, 5994.850128746729, 6003.459688628044, 6063.454289114001, 1430.5779794960304, 1445.6819499710048, 1449.1884544655027, 1449.9637509062359, 1451.8548145185398, 757.9242075792376, 811.4279432999721, 834.9373796965252, 881.5019513974584, 885.7298523950257, 5071.54356107952, 5506.559475241971, 5644.915326270109, 5706.400827913092, 5794.391588883106, 4939.5554400104165, 5724.427557244242, 6034.702538954146, 6229.688515574203, 6296.842578935563, 4801.903961920742, 4997.400311962588, 5385.38068122171, 5611.579131565149, 5704.71476426177, 2618.5679362904907, 3214.4053350129834, 3226.2418331692033, 3229.7081167532706, 3243.351329734063, 6008.317671052112, 6307.653079080695, 6355.3009168991375, 6364.554481186365, 6412.050456789929, 5667.874547044858, 6157.538184636171, 6287.805316989758, 6351.174347334817, 6374.490040796725, 5156.329677142097, 5891.348892998168, 6231.694273118885, 6352.6801774793585, 6373.553851230369, 4957.231629097496, 5291.60312976536, 5364.624476286778, 5839.284732599362, 5994.490468310242, 4778.402699662543, 5002.924956125734, 5667.659940403589, 6137.539684523768, 6201.782937597162, 5722.281916089824, 5986.311574169026, 6453.806385808433, 6454.967725161344, 6494.805155845333, 3368.4105281575135, 4147.79261036953, 4156.210320039183, 4161.500619925629, 4170.893698682146, 5257.947420525746, 5267.78928842842, 5497.038018346853, 5981.043033114681, 6257.843553911189, 4965.45380008206, 5943.435373639497, 5998.940010599838, 6030.638161710136, 6058.7273572688455, 4887.780049897692, 6128.448439640454, 6132.693365331805, 6132.938670613236, 6150.569460137926, 5373.811916582901, 5860.413958604106, 5881.176635271151, 6013.053603734052, 6062.727177277121, 4735.502772208868, 4878.341423907869, 5778.988676981596, 6025.879482410415, 6083.574149809471, 4654.2785868190485, 5846.269216347957, 5910.083936989773, 5955.434233747787, 5997.610155339889], "value": 4293.1611363956135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.1598487761756, 724.5725022236883, 779.2674885607529, 794.3605397654885, 813.1015228172871, 16066.036037837723, 16597.41909033184, 16631.584210394747, 16641.001539907615, 16656.833431665695, 14702.926485367585, 14752.114873107594, 14829.110253384804, 14870.182139982297, 14921.552353429415, 670.4066900792809, 829.5022986208287, 847.4745657692224, 857.0615176381851, 869.0874581689233, 860.3031544448985, 863.0463338011501, 866.800635853754, 868.4962721621445, 871.3508436215029, 919.3610440743686, 920.9217216536603, 921.8663293822392, 922.229938001766, 925.6806401791405, 898.348697194532, 908.2098574240387, 911.8723378726984, 914.8444764390069, 916.5371487398854, 673.3502170405582, 679.1883698979722, 681.0057316318181, 686.6669665212368, 686.8351595617016, 14935.253237338198, 14941.327640256215, 14953.476628317956, 14959.775603365959, 14970.850291497054, 14744.189069601167, 14762.852371476256, 14791.852081479155, 14796.18620975846, 14900.403983840633, 11924.224925379822, 12134.696632584168, 12393.62819115419, 12394.504219831197, 12540.122191446602, 3845.1540661054523, 3853.7495062820826, 4029.637332640047, 4074.4703188585295, 4075.8777236682945, 125066.37466812698, 126656.36671816674, 127422.0, 128269.0, 128481.0, 7945.165757595485, 10019.298649094639, 11215.04672102864, 11270.21108522412, 11674.824877626843, 16389.67220655604, 17027.48917532476, 17107.48677539676, 21641.675374869388, 21696.0, 6677.599344039373, 7745.728899488604, 7865.174156713577, 8035.477693949874, 8091.55496447701, 3954.9519377365023, 4471.8434854779925, 4533.863984080483, 4590.724556526619, 4681.32120842476, 2902.5210840211553, 3623.6592460789147, 3628.9818550907603, 3636.345457817565, 3637.5816781069984, 591.3170288317001, 620.1534904854841, 647.9222493300834, 654.4633400611453, 668.1881513960561, 509.27936969188926, 510.7573902396332, 583.3087790967717, 596.9224000879858, 618.8685252621748, 8252.504849709037, 8846.115388461103, 9143.177114059767, 9172.403793753385, 9186.494742789077, 551.1237132958615, 591.8727473593198, 613.9815805525841, 623.4731651754261, 646.618495087891, 3490.8254587270535, 4422.933655995163, 4549.27211646135, 5062.294428386311, 5111.284420181178, 165030.0, 165218.0, 166916.0, 168035.31964680197, 170983.0, 137530.0, 139291.0, 140368.0, 140646.0, 141691.0, 118533.40733296279, 118853.0, 119396.0, 119928.0, 121295.0, 9774.48100761681, 10215.591376344863, 10228.386296822215, 10295.330803497749, 10304.227182961458, 65956.34043659693, 66488.0, 67274.66362668155, 68099.97850032154, 68938.0, 100312.0, 103768.0, 104113.0, 104457.0, 107123.0, 12837.358132093545, 13246.0, 13599.388027538587, 13861.306934653428, 14058.929705351817, 15188.696226075195, 15226.543203703906, 15326.624373222168, 15937.601559961095, 15978.360865565712, 14000.64998375008, 14086.15483071019, 14169.43322267139, 14760.114393136446, 14870.256487175815, 12669.746605067663, 12928.38454880959, 13064.150830196008, 13169.868301316865, 13311.400986955416, 13822.0, 13940.233287169303, 14040.0, 14269.286535672967, 14500.854991450373, 11242.83135752948, 11527.88472115268, 11539.769204616028, 11612.6516204514, 11893.821592675944, 8938.46369217849, 9854.901450985684, 9857.654982075594, 10450.32794752836, 10876.619318324138], "value": 7962.758583182021, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 93.0, 159.0, 101.0, 109.0, 125.0, 173.0, 170.0, 130.0, 118.0], "value": 133.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 139.0, 162.0, 112.0, 133.0, 130.0, 114.0, 160.0, 119.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 231.0, 199.0, 206.0, 203.0, 201.0, 198.0, 205.0, 218.0, 197.0], "value": 206.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 85.0, 77.0, 151.0, 61.0, 60.0, 61.0, 65.0, 145.0, 59.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 119.0, 93.0, 102.0, 61.0, 132.0, 102.0, 103.0, 152.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 132.0, 121.0, 87.0, 100.0, 115.0, 90.0, 85.0, 89.0, 87.0], "value": 98.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 134.0, 150.0, 107.0, 96.0, 95.0, 133.0], "value": 109.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 92.0, 91.0, 90.0, 91.0, 90.0, 92.0, 101.0, 92.0, 153.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 62.0, 55.0, 57.0, 60.0, 56.0, 56.0, 57.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 65.0, 71.0, 68.0, 75.0, 74.0, 64.0, 103.0, 103.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 95.0, 88.0, 86.0, 88.0, 93.0, 88.0, 89.0, 86.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 148.0, 135.0, 147.0, 154.0, 166.0, 157.0, 164.0, 153.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 199.0, 156.0, 240.0, 237.0, 173.0, 176.0, 174.0, 173.0, 171.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 68.0, 70.0, 66.0, 68.0, 68.0, 70.0, 71.0], "value": 68.7, "unit": "score"}]}]} 10:30:12 INFO - Return code: 0 10:30:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:30:12 ERROR - # TBPL SUCCESS # 10:30:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:30:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:30:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:30:12 INFO - 2016-08-18 10:30:12.988 screenresolution[1930:20696] starting screenresolution argv=screenresolution get 10:30:12 INFO - 2016-08-18 10:30:12.990 screenresolution[1930:20696] Display 0: 1600x1200x32@60 10:30:12 INFO - 2016-08-18 10:30:12.996 screenresolution[1931:20699] starting screenresolution argv=screenresolution list 10:30:12 INFO - Available Modes on Display 0 10:30:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:30:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:30:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:30:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:30:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:30:13 INFO - Intel Iris: 10:30:13 INFO - Chipset Model: Intel Iris 10:30:13 INFO - Type: GPU 10:30:13 INFO - Bus: Built-In 10:30:13 INFO - VRAM (Dynamic, Max): 1536 MB 10:30:13 INFO - Vendor: Intel (0x8086) 10:30:13 INFO - Device ID: 0x0a2e 10:30:13 INFO - Revision ID: 0x0009 10:30:13 INFO - Displays: 10:30:13 INFO - Display: 10:30:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:30:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:30:13 INFO - Display Serial Number: 1600x1200 60 10:30:13 INFO - Main Display: Yes 10:30:13 INFO - Mirror: Off 10:30:13 INFO - Online: Yes 10:30:13 INFO - Rotation: Supported 10:30:13 INFO - Return code: 0 10:30:13 INFO - Running post-action listener: _resource_record_post_action 10:30:13 INFO - [mozharness: 2016-08-18 17:30:13.230112Z] Finished run-tests step (success) 10:30:13 INFO - Running post-run listener: _resource_record_post_run 10:30:13 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 1560576; Write bytes: 705843200; Read time: 10; Write time: 1792 10:30:13 INFO - TinderboxPrint: CPU usage
54.4% 10:30:13 INFO - TinderboxPrint: I/O read bytes / time
1,560,576 / 10 10:30:13 INFO - TinderboxPrint: I/O write bytes / time
705,843,200 / 1,792 10:30:13 INFO - TinderboxPrint: CPU idle
2,206.7 (45.6%) 10:30:13 INFO - TinderboxPrint: CPU system
983.5 (20.3%) 10:30:13 INFO - TinderboxPrint: CPU user
1,651.6 (34.1%) 10:30:13 INFO - TinderboxPrint: Swap in / out
406,794,240 / 0 10:30:13 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394351104; Write bytes: 388920832; Read time: 29242; Write time: 669 10:30:13 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1560576; Write bytes: 296909312; Read time: 10; Write time: 1076 10:30:13 INFO - Running post-run listener: _upload_blobber_files 10:30:13 INFO - Blob upload gear active. 10:30:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:30:13 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 10:30:13 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'] 10:30:13 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 10:30:14 INFO - (blobuploader) - INFO - Open directory for files ... 10:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:15 INFO - (blobuploader) - INFO - Done attempting. 10:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:16 INFO - (blobuploader) - INFO - Done attempting. 10:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:30:18 INFO - (blobuploader) - INFO - Done attempting. 10:30:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:30:18 INFO - Return code: 0 10:30:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:30:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:30:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b035fdd10fbda133ed18b8d5acd562e459ef5f22284b09c690a84ba2a283d9367c563e6e64d02f4f782c6ebc5a6eedf2c127fb005b50960a35edafbb4d088c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a8fd1233f6d38b87790f04da7bf598264568fe941342d8549badd1c48c322a24d37b4c86f73e504d3c6a98398f94ed20a6e8e6ae58dbc42533dad15e902a630", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c78748d6251898ec3134d9600e1b08067b54990c76c0f62d9b8d29d341af1d99b209c0d589d35826c67499635629292f971bbe8af7c240174bbc8d774d53572"} 10:30:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:30:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:30:18 INFO - Contents: 10:30:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1b035fdd10fbda133ed18b8d5acd562e459ef5f22284b09c690a84ba2a283d9367c563e6e64d02f4f782c6ebc5a6eedf2c127fb005b50960a35edafbb4d088c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a8fd1233f6d38b87790f04da7bf598264568fe941342d8549badd1c48c322a24d37b4c86f73e504d3c6a98398f94ed20a6e8e6ae58dbc42533dad15e902a630", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c78748d6251898ec3134d9600e1b08067b54990c76c0f62d9b8d29d341af1d99b209c0d589d35826c67499635629292f971bbe8af7c240174bbc8d774d53572"} 10:30:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:30:18 INFO - Copying logs to upload dir... 10:30:18 INFO - mkdir: /builds/slave/test/build/upload/logs 10:30:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.103151 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-18 10:30:18.734515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 10:30:18.738064) ========= 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.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/c1b035fdd10fbda133ed18b8d5acd562e459ef5f22284b09c690a84ba2a283d9367c563e6e64d02f4f782c6ebc5a6eedf2c127fb005b50960a35edafbb4d088c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a8fd1233f6d38b87790f04da7bf598264568fe941342d8549badd1c48c322a24d37b4c86f73e504d3c6a98398f94ed20a6e8e6ae58dbc42533dad15e902a630", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c78748d6251898ec3134d9600e1b08067b54990c76c0f62d9b8d29d341af1d99b209c0d589d35826c67499635629292f971bbe8af7c240174bbc8d774d53572"} build_url:https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010965 build_url: 'https://queue.taskcluster.net/v1/task/bMXuM3tuSFaCbUtlsFQTAg/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/c1b035fdd10fbda133ed18b8d5acd562e459ef5f22284b09c690a84ba2a283d9367c563e6e64d02f4f782c6ebc5a6eedf2c127fb005b50960a35edafbb4d088c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a8fd1233f6d38b87790f04da7bf598264568fe941342d8549badd1c48c322a24d37b4c86f73e504d3c6a98398f94ed20a6e8e6ae58dbc42533dad15e902a630", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c78748d6251898ec3134d9600e1b08067b54990c76c0f62d9b8d29d341af1d99b209c0d589d35826c67499635629292f971bbe8af7c240174bbc8d774d53572"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 10:30:18.770575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:30:18.770917) ========= 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.FGNhzPItHH/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.C2Akgriwk7/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 10:30:18.819453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 10:30:18.819782) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 10:30:18.820134) ========= ========= Total master_lag: 0.18 =========