builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1472764077.0 results: success (0) buildid: 20160901111321 builduid: f0df6025abeb4b85b733ba7b66f4dc2d revision: d667c9cd84f16752ae92c2b683afcc35e0483ec3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.002012) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.002446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.002764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.027871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.028532) ========= 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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-09-01 14:07:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.13M=0.002s 2016-09-01 14:07:57 (6.13 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.158597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.158938) ========= 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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.020410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:57.207600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 14:07:57.208976) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d667c9cd84f16752ae92c2b683afcc35e0483ec3 --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 d667c9cd84f16752ae92c2b683afcc35e0483ec3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-09-01 14:07:57,281 truncating revision to first 12 chars 2016-09-01 14:07:57,281 Setting DEBUG logging. 2016-09-01 14:07:57,281 attempt 1/10 2016-09-01 14:07:57,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d667c9cd84f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 14:07:58,036 unpacking tar archive at: fx-team-d667c9cd84f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034442 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 14:07:58.301393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:58.301741) ========= script_repo_revision: d667c9cd84f16752ae92c2b683afcc35e0483ec3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:58.302169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:58.302443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 14:07:58.321376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-01 14:07:58.321737) ========= /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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:07:58 INFO - MultiFileLogger online at 20160901 14:07:58 in /builds/slave/test 14:07:58 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 14:07:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:58 INFO - {'append_to_log': False, 14:07:58 INFO - 'base_work_dir': '/builds/slave/test', 14:07:58 INFO - 'blob_upload_branch': 'Fx-Team', 14:07:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:58 INFO - 'branch': 'Fx-Team', 14:07:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:58 INFO - 'config_files': ('talos/mac_config.py',), 14:07:58 INFO - 'default_actions': ('clobber', 14:07:58 INFO - 'read-buildbot-config', 14:07:58 INFO - 'download-and-extract', 14:07:58 INFO - 'populate-webroot', 14:07:58 INFO - 'create-virtualenv', 14:07:58 INFO - 'install', 14:07:58 INFO - 'run-tests'), 14:07:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:58 INFO - 'download_minidump_stackwalk': True, 14:07:58 INFO - 'download_symbols': 'ondemand', 14:07:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:58 INFO - 'installer_path': 'installer.exe', 14:07:58 INFO - 'log_level': 'info', 14:07:58 INFO - 'log_name': 'talos', 14:07:58 INFO - 'log_to_console': True, 14:07:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:07:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:07:58 INFO - 'opt_config_files': (), 14:07:58 INFO - 'pip_index': False, 14:07:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:07:58 INFO - 'cmd': ('bash', 14:07:58 INFO - '-c', 14:07:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:07:58 INFO - 'enabled': True, 14:07:58 INFO - 'halt_on_failure': False, 14:07:58 INFO - 'name': 'check_screen_resolution'},), 14:07:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:07:58 INFO - 'cmd': ('bash', 14:07:58 INFO - '-c', 14:07:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:07:58 INFO - 'enabled': True, 14:07:58 INFO - 'halt_on_failure': False, 14:07:58 INFO - 'name': 'check_screen_resolution'},), 14:07:58 INFO - 'run_cmd_checks_enabled': True, 14:07:58 INFO - 'sps_profile': False, 14:07:58 INFO - 'sps_profile_interval': 0, 14:07:58 INFO - 'suite': 'dromaeojs-e10s', 14:07:58 INFO - 'system_bits': '32', 14:07:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:58 INFO - 'title': 't-yosemite-r7-0014', 14:07:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:58 INFO - 'use_talos_json': True, 14:07:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:58 INFO - 'work_dir': 'build'} 14:07:58 INFO - [mozharness: 2016-09-01 21:07:58.512062Z] Running clobber step. 14:07:58 INFO - Running pre-action listener: _resource_record_pre_action 14:07:58 INFO - Running main action method: clobber 14:07:58 INFO - rmtree: /builds/slave/test/build 14:07:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:58 INFO - Running post-action listener: _resource_record_post_action 14:07:58 INFO - [mozharness: 2016-09-01 21:07:58.701907Z] Finished clobber step (success) 14:07:58 INFO - [mozharness: 2016-09-01 21:07:58.702039Z] Running read-buildbot-config step. 14:07:58 INFO - Running pre-action listener: _resource_record_pre_action 14:07:58 INFO - Running main action method: read_buildbot_config 14:07:58 INFO - Using buildbot properties: 14:07:58 INFO - { 14:07:58 INFO - "project": "", 14:07:58 INFO - "product": "firefox", 14:07:58 INFO - "script_repo_revision": "production", 14:07:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:07:58 INFO - "repository": "", 14:07:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:07:58 INFO - "buildid": "20160901111321", 14:07:58 INFO - "pgo_build": "False", 14:07:58 INFO - "basedir": "/builds/slave/test", 14:07:58 INFO - "buildnumber": 15, 14:07:58 INFO - "slavename": "t-yosemite-r7-0014", 14:07:58 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:07:58 INFO - "platform": "yosemite_r7", 14:07:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 14:07:58 INFO - "branch": "fx-team", 14:07:58 INFO - "repo_path": "integration/fx-team", 14:07:58 INFO - "revision": "d667c9cd84f16752ae92c2b683afcc35e0483ec3", 14:07:58 INFO - "stage_platform": "macosx64", 14:07:58 INFO - "builduid": "f0df6025abeb4b85b733ba7b66f4dc2d", 14:07:58 INFO - "slavebuilddir": "test" 14:07:58 INFO - } 14:07:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:07:58 INFO - Running post-action listener: _resource_record_post_action 14:07:58 INFO - [mozharness: 2016-09-01 21:07:58.705247Z] Finished read-buildbot-config step (success) 14:07:58 INFO - [mozharness: 2016-09-01 21:07:58.705379Z] Running download-and-extract step. 14:07:58 INFO - Running pre-action listener: _resource_record_pre_action 14:07:58 INFO - Running main action method: download_and_extract 14:07:58 INFO - mkdir: /builds/slave/test/build/tests 14:07:58 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')]} 14:07:58 INFO - trying https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:07:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:07:59 INFO - Downloaded 1199 bytes. 14:07:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:07:59 INFO - Using the following test package requirements: 14:07:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:07:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:07:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:07:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'jsshell-mac.zip'], 14:07:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:07:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:07:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:07:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:07:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:07:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:07:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:07:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:07:59 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')]} 14:07:59 INFO - trying https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:07:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:00 INFO - Downloaded 16399299 bytes. 14:08:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:08:07 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 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:07 INFO - trying https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:08:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:08 INFO - Downloaded 16399299 bytes. 14:08:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:15 INFO - trying https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:08:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:16 INFO - Downloaded 14413998 bytes. 14:08:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:16 INFO - trying https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:08:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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 14:08:19 INFO - Downloaded 111577081 bytes. 14:08:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:08:19 INFO - mkdir: /builds/slave/test/properties 14:08:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:19 INFO - Contents: 14:08:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:08:19 INFO - Running post-action listener: _resource_record_post_action 14:08:19 INFO - Running post-action listener: set_extra_try_arguments 14:08:19 INFO - [mozharness: 2016-09-01 21:08:19.938651Z] Finished download-and-extract step (success) 14:08:19 INFO - [mozharness: 2016-09-01 21:08:19.938776Z] Running populate-webroot step. 14:08:19 INFO - Running pre-action listener: _resource_record_pre_action 14:08:19 INFO - Running main action method: populate_webroot 14:08:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:19 INFO - '--tppagecycles', 14:08:19 INFO - '7'], 14:08:19 INFO - 'tests': ['tsvgm']}}, 14:08:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['damp', 'tps']}, 14:08:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'tests': ['damp', 'tps']}, 14:08:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['dromaeo_dom']}, 14:08:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['basic_compositor_video']}, 14:08:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:08:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['a11yr', 14:08:19 INFO - 'ts_paint', 14:08:19 INFO - 'tpaint', 14:08:19 INFO - 'sessionrestore', 14:08:19 INFO - 'sessionrestore_no_auto_restore', 14:08:19 INFO - 'tabpaint']}, 14:08:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['tsvgx', 14:08:19 INFO - 'tsvgr_opacity', 14:08:19 INFO - 'tart', 14:08:19 INFO - 'tscrollx', 14:08:19 INFO - 'cart']}, 14:08:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:19 INFO - 'tsvgr_opacity', 14:08:19 INFO - 'tart', 14:08:19 INFO - 'tscrollx', 14:08:19 INFO - 'cart']}, 14:08:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'talos_options': ['--disable-e10s'], 14:08:19 INFO - 'tests': ['tp5o']}, 14:08:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'tests': ['tp5o']}, 14:08:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'talos_options': ['--disable-e10s', 14:08:19 INFO - '--xperf_path', 14:08:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:19 INFO - 'tests': ['tp5n']}, 14:08:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:19 INFO - 'talos_options': ['--xperf_path', 14:08:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:19 INFO - 'tests': ['tp5n']}}, 14:08:19 INFO - 'talos.zip': {'path': '', 14:08:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:19 INFO - Running post-action listener: _resource_record_post_action 14:08:19 INFO - [mozharness: 2016-09-01 21:08:19.957427Z] Finished populate-webroot step (success) 14:08:19 INFO - [mozharness: 2016-09-01 21:08:19.957536Z] Running create-virtualenv step. 14:08:19 INFO - Running pre-action listener: _resource_record_pre_action 14:08:19 INFO - Running main action method: create_virtualenv 14:08:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:19 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 14:08:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:20 INFO - Using real prefix '/tools/python27' 14:08:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:23 INFO - Installing pip.................done. 14:08:23 INFO - Return code: 0 14:08:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:23 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')]} 14:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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')]} 14:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:23 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 14:08:23 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 14:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:23 INFO - 'HOME': '/Users/cltbld', 14:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:23 INFO - 'LOGNAME': 'cltbld', 14:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:23 INFO - 'MOZ_NO_REMOTE': '1', 14:08:23 INFO - 'NO_EM_RESTART': '1', 14:08:23 INFO - 'PAGER': '/bin/cat', 14:08:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:23 INFO - 'PWD': '/builds/slave/test', 14:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:23 INFO - 'SHELL': '/bin/bash', 14:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:23 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:23 INFO - 'USER': 'cltbld', 14:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:23 INFO - 'XPC_FLAGS': '0x0', 14:08:23 INFO - 'XPC_SERVICE_NAME': '0', 14:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:23 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 14:08:23 INFO - Cleaning up... 14:08:23 INFO - Return code: 0 14:08:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08:23 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')]} 14:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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')]} 14:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:23 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 14:08:23 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 14:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:23 INFO - 'HOME': '/Users/cltbld', 14:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:23 INFO - 'LOGNAME': 'cltbld', 14:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:23 INFO - 'MOZ_NO_REMOTE': '1', 14:08:23 INFO - 'NO_EM_RESTART': '1', 14:08:23 INFO - 'PAGER': '/bin/cat', 14:08:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:23 INFO - 'PWD': '/builds/slave/test', 14:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:23 INFO - 'SHELL': '/bin/bash', 14:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:23 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:23 INFO - 'USER': 'cltbld', 14:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:23 INFO - 'XPC_FLAGS': '0x0', 14:08:23 INFO - 'XPC_SERVICE_NAME': '0', 14:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:24 INFO - Downloading/unpacking psutil>=3.1.1 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:24 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 14:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:27 INFO - Installing collected packages: psutil 14:08:27 INFO - Running setup.py install for psutil 14:08:27 INFO - building 'psutil._psutil_osx' extension 14:08:27 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 14:08:27 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 14:08:27 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 14:08:27 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 14:08:27 INFO - building 'psutil._psutil_posix' extension 14:08:27 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 14:08:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:08:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:08:27 INFO - ^ 14:08:27 INFO - 1 warning generated. 14:08:27 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 14:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:28 INFO - Successfully installed psutil 14:08:28 INFO - Cleaning up... 14:08:28 INFO - Return code: 0 14:08:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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')]} 14:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:28 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:28 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 14:08:28 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 14:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:28 INFO - 'HOME': '/Users/cltbld', 14:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:28 INFO - 'LOGNAME': 'cltbld', 14:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:28 INFO - 'MOZ_NO_REMOTE': '1', 14:08:28 INFO - 'NO_EM_RESTART': '1', 14:08:28 INFO - 'PAGER': '/bin/cat', 14:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:28 INFO - 'PWD': '/builds/slave/test', 14:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:28 INFO - 'SHELL': '/bin/bash', 14:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:28 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:28 INFO - 'USER': 'cltbld', 14:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:28 INFO - 'XPC_FLAGS': '0x0', 14:08:28 INFO - 'XPC_SERVICE_NAME': '0', 14:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:28 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 14:08:28 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 14:08:28 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 14:08:28 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 14:08:28 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 14:08:28 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 14:08:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:30 INFO - Installing collected packages: mozsystemmonitor 14:08:30 INFO - Running setup.py install for mozsystemmonitor 14:08:31 INFO - Successfully installed mozsystemmonitor 14:08:31 INFO - Cleaning up... 14:08:31 INFO - Return code: 0 14:08:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:31 INFO - 'HOME': '/Users/cltbld', 14:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:31 INFO - 'LOGNAME': 'cltbld', 14:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:31 INFO - 'MOZ_NO_REMOTE': '1', 14:08:31 INFO - 'NO_EM_RESTART': '1', 14:08:31 INFO - 'PAGER': '/bin/cat', 14:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:31 INFO - 'PWD': '/builds/slave/test', 14:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:31 INFO - 'SHELL': '/bin/bash', 14:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:31 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:31 INFO - 'USER': 'cltbld', 14:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:31 INFO - 'XPC_FLAGS': '0x0', 14:08:31 INFO - 'XPC_SERVICE_NAME': '0', 14:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:34 INFO - warning: no files found matching '*.txt' 14:08:34 INFO - no previously-included directories found matching 'build' 14:08:34 INFO - no previously-included directories found matching 'dist' 14:08:34 INFO - no previously-included directories found matching '.git*' 14:08:34 INFO - Installing collected packages: jsonschema, functools32 14:08:34 INFO - Running setup.py install for functools32 14:08:34 INFO - warning: no files found matching '*.txt' 14:08:34 INFO - no previously-included directories found matching 'build' 14:08:34 INFO - no previously-included directories found matching 'dist' 14:08:34 INFO - no previously-included directories found matching '.git*' 14:08:34 INFO - Successfully installed jsonschema functools32 14:08:34 INFO - Cleaning up... 14:08:34 INFO - Return code: 0 14:08:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:34 INFO - 'HOME': '/Users/cltbld', 14:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:34 INFO - 'LOGNAME': 'cltbld', 14:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:34 INFO - 'MOZ_NO_REMOTE': '1', 14:08:34 INFO - 'NO_EM_RESTART': '1', 14:08:34 INFO - 'PAGER': '/bin/cat', 14:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:34 INFO - 'PWD': '/builds/slave/test', 14:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:34 INFO - 'SHELL': '/bin/bash', 14:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:34 INFO - 'USER': 'cltbld', 14:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:34 INFO - 'XPC_FLAGS': '0x0', 14:08:34 INFO - 'XPC_SERVICE_NAME': '0', 14:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:08:34 INFO - Cleaning up... 14:08:34 INFO - Return code: 0 14:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:34 INFO - 'HOME': '/Users/cltbld', 14:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:34 INFO - 'LOGNAME': 'cltbld', 14:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:34 INFO - 'MOZ_NO_REMOTE': '1', 14:08:34 INFO - 'NO_EM_RESTART': '1', 14:08:34 INFO - 'PAGER': '/bin/cat', 14:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:34 INFO - 'PWD': '/builds/slave/test', 14:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:34 INFO - 'SHELL': '/bin/bash', 14:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:34 INFO - 'USER': 'cltbld', 14:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:34 INFO - 'XPC_FLAGS': '0x0', 14:08:34 INFO - 'XPC_SERVICE_NAME': '0', 14:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:35 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:35 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 14:08:35 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 14:08:35 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 14:08:35 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 14:08:35 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 14:08:35 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 14:08:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:38 INFO - Downloading docopt-0.6.1.tar.gz 14:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:38 INFO - Running setup.py install for blobuploader 14:08:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:39 INFO - Running setup.py install for requests 14:08:39 INFO - Running setup.py install for docopt 14:08:39 INFO - Successfully installed blobuploader requests docopt 14:08:39 INFO - Cleaning up... 14:08:39 INFO - Return code: 0 14:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:39 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:39 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 14:08:39 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 14:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:39 INFO - 'HOME': '/Users/cltbld', 14:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:39 INFO - 'LOGNAME': 'cltbld', 14:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:39 INFO - 'MOZ_NO_REMOTE': '1', 14:08:39 INFO - 'NO_EM_RESTART': '1', 14:08:39 INFO - 'PAGER': '/bin/cat', 14:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:39 INFO - 'PWD': '/builds/slave/test', 14:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:39 INFO - 'SHELL': '/bin/bash', 14:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:39 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:39 INFO - 'USER': 'cltbld', 14:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:39 INFO - 'XPC_FLAGS': '0x0', 14:08:39 INFO - 'XPC_SERVICE_NAME': '0', 14:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gNkzcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AAPXhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-sm4asQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-vWOCwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-goFwui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1p1uiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-V9Nx5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jTuX0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-kGMCdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:40 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-yv2u2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-kyb83b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-lyO3hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-aRb6S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-iE4kvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-OCE2w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PyEwPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:41 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-B2gfzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:41 INFO - Running setup.py install for manifestparser 14:08:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:41 INFO - Running setup.py install for mozcrash 14:08:42 INFO - Running setup.py install for mozdebug 14:08:42 INFO - Running setup.py install for mozdevice 14:08:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Running setup.py install for mozfile 14:08:42 INFO - Running setup.py install for mozhttpd 14:08:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Running setup.py install for mozinfo 14:08:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Running setup.py install for mozInstall 14:08:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:42 INFO - Running setup.py install for mozleak 14:08:43 INFO - Running setup.py install for mozlog 14:08:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Running setup.py install for moznetwork 14:08:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Running setup.py install for mozprocess 14:08:43 INFO - Running setup.py install for mozprofile 14:08:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Running setup.py install for mozrunner 14:08:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:43 INFO - Running setup.py install for mozscreenshot 14:08:44 INFO - Running setup.py install for moztest 14:08:44 INFO - Running setup.py install for mozversion 14:08:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:44 INFO - Cleaning up... 14:08:44 INFO - Return code: 0 14:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:44 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:44 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 14:08:44 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 14:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:44 INFO - 'HOME': '/Users/cltbld', 14:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:44 INFO - 'LOGNAME': 'cltbld', 14:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:44 INFO - 'MOZ_NO_REMOTE': '1', 14:08:44 INFO - 'NO_EM_RESTART': '1', 14:08:44 INFO - 'PAGER': '/bin/cat', 14:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:44 INFO - 'PWD': '/builds/slave/test', 14:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:44 INFO - 'SHELL': '/bin/bash', 14:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:44 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:44 INFO - 'USER': 'cltbld', 14:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:44 INFO - 'XPC_FLAGS': '0x0', 14:08:44 INFO - 'XPC_SERVICE_NAME': '0', 14:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1D5zUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:44 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)) 14:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qFaJQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:44 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)) 14:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0SaFZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JnIGV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-IoFx7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gl7Drs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-MBTuR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uc0Zl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-WkLkLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-0bfZY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2EYUEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:45 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6e1WPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:45 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)) 14:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-end6UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:46 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)) 14:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6DohRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:46 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)) 14:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Fmhz_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:46 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)) 14:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-GO9aHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:46 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)) 14:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-D1e06o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:46 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)) 14:08:46 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)) 14:08:46 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)) 14:08:46 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)) 14:08:46 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)) 14:08:46 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)) 14:08:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08: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 14:08:48 INFO - Downloading blessings-1.6.tar.gz 14:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:49 INFO - Installing collected packages: blessings 14:08:49 INFO - Running setup.py install for blessings 14:08:49 INFO - Successfully installed blessings 14:08:49 INFO - Cleaning up... 14:08:49 INFO - Return code: 0 14:08:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:49 INFO - Reading from file tmpfile_stdout 14:08:49 INFO - Current package versions: 14:08:49 INFO - blessings == 1.6 14:08:49 INFO - blobuploader == 1.2.4 14:08:49 INFO - docopt == 0.6.1 14:08:49 INFO - functools32 == 3.2.3-2 14:08:49 INFO - jsonschema == 2.5.1 14:08:49 INFO - manifestparser == 1.1 14:08:49 INFO - mozInstall == 1.12 14:08:49 INFO - mozcrash == 0.17 14:08:49 INFO - mozdebug == 0.1 14:08:49 INFO - mozdevice == 0.48 14:08:49 INFO - mozfile == 1.2 14:08:49 INFO - mozhttpd == 0.7 14:08:49 INFO - mozinfo == 0.9 14:08:49 INFO - mozleak == 0.1 14:08:49 INFO - mozlog == 3.3 14:08:49 INFO - moznetwork == 0.27 14:08:49 INFO - mozprocess == 0.23 14:08:49 INFO - mozprofile == 0.28 14:08:49 INFO - mozrunner == 6.12 14:08:49 INFO - mozscreenshot == 0.1 14:08:49 INFO - mozsystemmonitor == 0.3 14:08:49 INFO - moztest == 0.7 14:08:49 INFO - mozversion == 1.4 14:08:49 INFO - psutil == 3.1.1 14:08:49 INFO - requests == 1.2.3 14:08:49 INFO - wsgiref == 0.1.2 14:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:49 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')]} 14:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:50 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 14:08:50 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 14:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:50 INFO - 'HOME': '/Users/cltbld', 14:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:50 INFO - 'LOGNAME': 'cltbld', 14:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:50 INFO - 'MOZ_NO_REMOTE': '1', 14:08:50 INFO - 'NO_EM_RESTART': '1', 14:08:50 INFO - 'PAGER': '/bin/cat', 14:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:50 INFO - 'PWD': '/builds/slave/test', 14:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:50 INFO - 'SHELL': '/bin/bash', 14:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:50 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:50 INFO - 'USER': 'cltbld', 14:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:50 INFO - 'XPC_FLAGS': '0x0', 14:08:50 INFO - 'XPC_SERVICE_NAME': '0', 14:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 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)) 14:08:50 INFO - Cleaning up... 14:08:50 INFO - Return code: 0 14:08:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:50 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 0x10456fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104604618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a9c5d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, '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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 14:08:50 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 14:08:50 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 14:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:08:50 INFO - 'HOME': '/Users/cltbld', 14:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:08:50 INFO - 'LOGNAME': 'cltbld', 14:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:50 INFO - 'MOZ_NO_REMOTE': '1', 14:08:50 INFO - 'NO_EM_RESTART': '1', 14:08:50 INFO - 'PAGER': '/bin/cat', 14:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:50 INFO - 'PWD': '/builds/slave/test', 14:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:08:50 INFO - 'SHELL': '/bin/bash', 14:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:08:50 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:08:50 INFO - 'USER': 'cltbld', 14:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:50 INFO - 'XPC_FLAGS': '0x0', 14:08:50 INFO - 'XPC_SERVICE_NAME': '0', 14:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:50 INFO - Cleaning up... 14:08:50 INFO - Return code: 0 14:08:50 INFO - Running post-action listener: _resource_record_post_action 14:08:50 INFO - Running post-action listener: _start_resource_monitoring 14:08:50 INFO - Starting resource monitoring. 14:08:50 INFO - [mozharness: 2016-09-01 21:08:50.598937Z] Finished create-virtualenv step (success) 14:08:50 INFO - [mozharness: 2016-09-01 21:08:50.599878Z] Running install step. 14:08:50 INFO - Running pre-action listener: _resource_record_pre_action 14:08:50 INFO - Running main action method: install 14:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:50 INFO - Reading from file tmpfile_stdout 14:08:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:50 INFO - Reading from file tmpfile_stdout 14:08:50 INFO - Output received: 14:08:50 INFO - Usage: mozinstall [options] installer 14:08:50 INFO - Options: 14:08:50 INFO - -h, --help show this help message and exit 14:08:50 INFO - -d DEST, --destination=DEST 14:08:50 INFO - Directory to install application into. [default: 14:08:50 INFO - "/builds/slave/test"] 14:08:50 INFO - --app=APP Application being installed. [default: firefox] 14:08:50 INFO - mkdir: /builds/slave/test/build/application 14:08:50 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'] 14:08:50 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 14:09:25 INFO - Reading from file tmpfile_stdout 14:09:25 INFO - Output received: 14:09:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:09:25 INFO - Running post-action listener: _resource_record_post_action 14:09:25 INFO - [mozharness: 2016-09-01 21:09:25.302841Z] Finished install step (success) 14:09:25 INFO - [mozharness: 2016-09-01 21:09:25.302976Z] Running run-tests step. 14:09:25 INFO - Running pre-action listener: _resource_record_pre_action 14:09:25 INFO - Running main action method: run_tests 14:09:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:25 INFO - 2016-09-01 14:09:25.317 screenresolution[1994:277697] starting screenresolution argv=screenresolution get 14:09:25 INFO - 2016-09-01 14:09:25.320 screenresolution[1994:277697] Display 0: 1600x1200x32@60 14:09:25 INFO - 2016-09-01 14:09:25.326 screenresolution[1995:277699] starting screenresolution argv=screenresolution list 14:09:25 INFO - Available Modes on Display 0 14:09:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:25 INFO - Intel Iris: 14:09:25 INFO - Chipset Model: Intel Iris 14:09:25 INFO - Type: GPU 14:09:25 INFO - Bus: Built-In 14:09:25 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:25 INFO - Vendor: Intel (0x8086) 14:09:25 INFO - Device ID: 0x0a2e 14:09:25 INFO - Revision ID: 0x0009 14:09:25 INFO - Displays: 14:09:25 INFO - Display: 14:09:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:25 INFO - Display Serial Number: 1600x1200 60 14:09:25 INFO - Main Display: Yes 14:09:25 INFO - Mirror: Off 14:09:25 INFO - Online: Yes 14:09:25 INFO - Rotation: Supported 14:09:25 INFO - Return code: 0 14:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:25 INFO - Python 2.7.3 14:09:25 INFO - Return code: 0 14:09:25 INFO - grabbing minidump binary from tooltool 14:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:25 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 0x1044d3d30>, '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 0x104238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044cbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:25 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 14:09:25 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 14:09:25 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 14:09:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:25 INFO - Return code: 0 14:09:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:09:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:09:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:25 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/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 14:09:25 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/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 14:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EXQbfdYMGl/Render', 14:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:25 INFO - 'HOME': '/Users/cltbld', 14:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:25 INFO - 'LOGNAME': 'cltbld', 14:09:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:25 INFO - 'MOZ_NO_REMOTE': '1', 14:09:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:25 INFO - 'NO_EM_RESTART': '1', 14:09:25 INFO - 'PAGER': '/bin/cat', 14:09:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:25 INFO - 'PWD': '/builds/slave/test', 14:09:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:25 INFO - 'SHELL': '/bin/bash', 14:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Bs4KX0xWh5/Listeners', 14:09:25 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 14:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:25 INFO - 'USER': 'cltbld', 14:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:25 INFO - 'XPC_FLAGS': '0x0', 14:09:25 INFO - 'XPC_SERVICE_NAME': '0', 14:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:25 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/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 14:09:25 INFO - mozversion application_buildid: 20160901111321 14:09:25 INFO - mozversion application_changeset: d667c9cd84f16752ae92c2b683afcc35e0483ec3 14:09:25 INFO - mozversion application_display_name: Nightly 14:09:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:25 INFO - mozversion application_name: Firefox 14:09:25 INFO - mozversion application_remotingname: firefox 14:09:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:09:25 INFO - mozversion application_vendor: Mozilla 14:09:25 INFO - mozversion application_version: 51.0a1 14:09:25 INFO - mozversion platform_buildid: 20160901111321 14:09:25 INFO - mozversion platform_changeset: d667c9cd84f16752ae92c2b683afcc35e0483ec3 14:09:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:09:25 INFO - mozversion platform_version: 51.0a1 14:09:25 INFO - using testdate: 1472764165 14:09:25 INFO - actual date: 1472764165 14:09:25 INFO - starting webserver on 'localhost:49375' 14:09:25 INFO - SUITE-START | Running 2 tests 14:09:25 INFO - TEST-START | dromaeo_css 14:09:25 INFO - operating with platform_type : mac_ 14:09:25 INFO - Initialising browser for dromaeo_css test... 14:09:25 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpTP9iEN/profile http://localhost:49375/getInfo.html) 14:09:28 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 14:09:28 INFO - PROCESS | 2005 | colorDepth:24 14:09:28 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 14:09:28 INFO - PROCESS | 2005 | __metrics 14:09:28 ERROR - PROCESS | 2005 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 14:09:29 INFO - TEST-INFO | 2005: exit 0 14:09:29 INFO - Browser initialized. 14:09:29 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:29 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpTP9iEN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:41 INFO - PROCESS | 2010 | RSS: Main: 245121024 14:09:41 INFO - PROCESS | 2010 | 14:10:31 INFO - PROCESS | 2010 | 1472764231314 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] 14:12:43 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49375/tests/dromaeo/cssquery-ext.html) 14:12:44 INFO - PROCESS | 2010 | RSS: Main: 269766656 14:12:44 INFO - PROCESS | 2010 | 14:15:47 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-ext.html (next: http://localhost:49375/tests/dromaeo/cssquery-jquery.html) 14:15:47 INFO - PROCESS | 2010 | RSS: Main: 276070400 14:15:47 INFO - PROCESS | 2010 | 14:18:49 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49375/tests/dromaeo/cssquery-mootools.html) 14:18:50 INFO - PROCESS | 2010 | RSS: Main: 276803584 14:18:50 INFO - PROCESS | 2010 | 14:21:52 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49375/tests/dromaeo/cssquery-prototype.html) 14:21:52 INFO - PROCESS | 2010 | RSS: Main: 272035840 14:21:52 INFO - PROCESS | 2010 | 14:24:55 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49375/tests/dromaeo/cssquery-yui.html) 14:24:56 INFO - PROCESS | 2010 | RSS: Main: 278364160 14:24:56 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-yui.html (next: http://localhost:49375/tests/dromaeo/cssquery-dojo.html) 14:27:58 INFO - PROCESS | 2010 | RSS: Main: 281440256 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | __start_tp_report 14:27:58 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 14:27:58 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 14:27:58 INFO - PROCESS | 2010 | |i|pagename|runs| 14:27:58 INFO - PROCESS | 2010 | |0;dojo.html;3154.1956801015735;3335.7331413486922;3343.933121337575;3373.3084717632887;3408.403529382358;4879.780409881555;4897.828575999841;5583.972080139599;5594.804181853636;5655.066913959192;4984.6541433812845;5272.1300985337375;5496.230527726121;5643.463870932265;5671.744771485282;4350.54319296474;5132.076226279269;5144.536991670759;5260.237265596486;5260.974110048542;5135.922961155567;5349.866253343658;5376.892462150755;5382.058139825534;5382.703951282678;5114.718690472023;5217.5565076968505;5236.7119808410525;5265.236540701615;5298.4436634153435;5142.434332223453;5210.505002024802;5218.269442278046;5240.135377662681;5247.9737601311745;5116.923246151311;5149.0989076911765;5174.275601415805;5181.35233095863;5182.144946083929;5495.516210623109;5506.146547285177;5525.419830917736;5584.246126772874;5692.146178073281;6102.974033066861;6113.480354169901;6154.984427569446;6193.566450348478;6206.162168107293;6209.16176316196;6226;6234.18955535782;6235.781747638856;6259.843503912393;4476.664250181184;4694.765261736899;5174.61190410717;5698.202251684767;5751.079827227665;5435.429279925551;5604.495595396353;6030.185924900083;6263.404976527223;6300.432961033529;5551.278333816578;5707.800226992118;6093.908591371133;6105;6119.418655227746;6045.818625441156;6120.325235636551;6192.380761923861;6231.189945307172;6246.3753624637175;5597.74810133545;6124.846878828065;6138.112525404923;6203.100550420254;6230.065490176419;5760.36635970043;6136.846578835565;6176.907346389808;6207.782727604512;6207.844803879849;4780.330753694486;4850.393700787402;4884.5603895649565;4887.535684110004;4890.853274401774;4268.701190916606;4346.195953748504;4360.716553424018;4407.2507673695545;4424.093060922503;5724.856878578069;5751.309842818889;5752.568557358215;5760.337561180434;5771.538276937835;6019.127226552126;6073.362296958844;6242.65665388408;6266.968665156736;6272.6236425814595;5005.824796132118;5780.16187652788;5804.4775970162045;5816.098504731774;5860;5386.057439948072;5407.675539467645;5414.187871819258;5425.050616142238;5429.945700542944;6190.319064902767;6195.690215489118;6215.595986260879;6293.937060629335;6299.937000630027;6142.836439233887;6238.563300568917;6243.594166379171;6250.968590182751;6253.749850006131;6264.624122552661;6267.780627678009;6284.402981716912;6289.182406287154;6334.113224148531;5122.871928201825;6114.266288045463;6134.601250918676;6135.386461354007;6155.630662160284;6081.087836824512;6145.754169833157;6221.813345599639;6224.657643829632;6232.034034724625;6096.775321244162;6101.023836186189;6119.173911522065;6120.782376608402;6128.411459112376;5937.524998000236;6023.789167379296;6096.514080138941;6111.419415155553;6113.2969708482315;4781.760911954458;5719.798842243175;5912.46787789101;5955.731992060454;6039.63762174271;6061.969690151521;6096.8780624388155;6105.481034111973;6109.938900610937;6112.235970503687;5782.942170578241;5887.352391236875;5896.7936122235515;5904.822855314347;5910.940890591039 14:27:58 INFO - PROCESS | 2010 | |1;ext.html;523.068937291621;540.5675459632293;541.2638811216746;542.9755660995255;579.8086631411635;38501.80749096254;41165.58834411655;41170.588294117086;41190.79404602977;41346.37980430296;41796.791016044874;42070.57929420705;42300;42333.57666423335;42501.724948251525;9648.71053868385;9845.704628861109;9857.014298570122;9897.723523589579;9903.207743380548;8404.369672274574;8461;9911;9940;9969.601215951354;8674.86987695185;9818.361806482591;9892.5161225816;9913.256505762061;9943.303968722192;9838.311318207656;9870.012998700144;9891.258155638356;9962.501874906298;9965.950170249174;8128.512289262663;9098.954505227432;9275.67535136267;9309.860352094724;9370.10983956523;40540.189196216204;40672.59327406718;40988;41260.79369603133;41312.79343603293;3340.2150494633743;3420.504026916108;3591.5331006969186;3854.6530812227033;4054.9594504054876;30910.845445772626;31042.844785776153;31149.377012459623;31204.907828225903;31300.686993130006;3271.492918597621;3279.9836000820083;3293.950590741141;3299.7525185611175;3365.5456513370627;473335;474472;474644;476580;477812;60083.699581501816;60317;60475;60557.69721151454;60589;34329.31341373159;34715.30569388598;35580;35966.280674386886;64243.67878160673;16611;16783.664326713642;16803;16804.915975420045;16837.158142092845;12732.29972351511;12850.55023074188;12852.807207891889;12872.485100596059;12906.548270810477;18610.534736631693;18623.44129676112;18916.71624925627;18953.336633217772;18972.715409268872;7931.56376399292;8086.706127019766;8103.270705636521;8170.264676179172;8329.167083291744;895.8880139982502;947.5641205045619;1013.5439052426437;1069.6149386220955;1074.409075008742;26886.865565672048;29344.853275733483;30406.84796576003;30844.383112337626;31007.379852403275;966.8791401074866;1048.4600430778155;1075.1398880895254;1077.3051381858656;1137.7041969088098;12186.451609677408;15878.7618185725;15884.444044458389;16196;16198.59503512398;583677;585649;587932;589702.1029789647;590177;41794.1641167175;42149.36775948363;42216;42311.57688423138;42418.78790606089;1351.9459221631025;1365.706373129782;1394.3864699532173;1397;1399.4122468563228;24683;25730.228093157235;29438;29515.55726664145;29994.850025749733;51615.74192129166;51616.74191629018;51737.741311293204;51798.741006294724;51802.222966656285;504838;508514;510756;511493.44253278495;511962;26440.471190576467;26610.866945665148;26862.194134176007;26877.92488300446;26902.730972690024;46565.67171641472;46816.297755533014;47250.291245632034;47272.527274728185;47833.28250076182;38214.6178538211;38970.6102938967;38976.6102338973;39278.2144357117;39351.40972885352;38804.80597597107;38831.805840970614;38868.6113138865;39777.60222397739;39987;37290.254194915404;37925.67260145881;38402.61597384102;38496.03759906025;38767;27418.862905685342;33823;34559.65440345564;34801.65198347984;34900;21637.567248655254;23691;24590.754092459563;25315.493690126463;26289.474210516066 14:27:58 INFO - PROCESS | 2010 | |2;jquery.html;345.89104432103886;361.8643008871673;371.502187069327;378.5967944139493;394.6487626012849;19202.903985480072;19413;19742.802571974276;20584.99999999998;20643.793562064377;19243.903780481112;19282.903585482054;19326.710099348522;19514.804851951478;19633.82197068177;5006.524380183895;5648.548116150709;5888.7055647217685;5902.527797776189;5907.822765317026;5874.6181498202695;6018.729157187915;6034.637921724689;6047.425494578008;6051.909221361661;5641.323041235058;5753.165790960308;5942.494887934531;5988.041913293874;5999.700014999255;5714.285714285715;5765.567582431314;5805.941940580582;5821.7380217890295;5841.737121829507;5061.215511595708;5071.56891664209;5077.416097148838;5356.91964620531;5418.29562156921;12530.185537940004;12534.059945504123;12682.239065656091;12723.04577156717;12724;2251.6509940959177;2255.875926824024;2357.634566642173;2819.309269229052;2864.8567571621334;9551.952240238823;9679.322447428684;9942.602295908155;10001.649942251986;14017.929910350485;1718.2267979409316;1767.7260024696193;1777.5822681669797;1802.2160360243206;1829.414587332041;103193.4840325801;109891;109895;109947;110004;10607.469626518643;10758.408287544104;10879.456027198608;11115.777684446266;11197.94401028006;13515.86484135146;13618.114822536503;13633;13651.976101792405;13684.04211705191;6491.448226900672;8301.501909885426;8317.085120636724;8368.958155209186;8369.916300836914;8152.714654987047;8278.71024514139;8299.713544400627;8395.370347223861;8460.703875364456;4198.6221240088535;4233.1956928183545;4292.9570704292555;4349.173657005159;4410.867673969786;1745.9786025175415;1852.1387554787088;1873.175802646831;1903.2957805611736;1913.4451009207173;811.6753298680575;861.1861790607941;904.864395184053;905.5200743605899;909.1771946388529;15420.537383878502;18475.90762046208;19823.900880495505;20066.498337541387;20257.392278231677;888.440282621944;922.7139586728001;925.9027802080819;952.2477242977969;1001.4291853643354;10079.143272821892;10314.381137131797;10361.963803619577;10388.740281493023;10411.375317480975;471742;545229;547594.7747693729;550002;552483;90679.54660226656;113796.43101784438;118076.40961795136;129025.35487322691;133162;986.9506524673737;996.6710985374809;1044.1177205261542;1044.7335929337971;1054.6361505280665;16108.355665773237;16487.258073386485;18000.09999500046;18069.909650451664;18448.538786530444;50256.4923052309;52151;53653.463465364846;54268.45731542792;54283.72858135684;74324.62837685777;77409.22590774245;77470.61264693641;77477;78532.21467785249;6623.834404139935;7444.994925684963;7793.9220607793195;7915.366770658448;8075.676972921252;11538.82691759641;11977.484728207173;12346.320952347707;12541;12559.748805023666;9588.616455341707;10806.621768238074;10918.23572349928;10957.671269861918;11163.330200188015;10651.57393704243;10824.242303039027;10908.672739817817;11115.777684446428;11205;11025.338479691245;11092.946170113826;11336.263142895685;11468.197226194086;11470.942645286721;5888.528917686489;6737.124173857367;7732.265434783687;7788.260115289038;8104.797380065545;9324.533773311172;10847.294925829796;10924.890751092706;10973.615923442641;11013.568236129251 14:27:58 INFO - PROCESS | 2010 | |3;mootools.html;1494.2827442827443;1521.6424140327024;1715.1595718098135;1804.7473353730488;1833.349161047828;7182.784516464508;8154.469959452631;8599.839021732065;9208.493532855699;9237.399569028017;7688.92311076889;9030.729078127666;9049.728508144766;9053.50205738684;9067.138621830933;2371.81025517959;2423.7333893271725;2424.7938925191293;2425.648280999254;2426.9029238830426;2400.567897778399;2417.16607770319;2447.2658202539255;2450.835852969843;2456.729759726438;2426.6602675625427;2432.20953190213;2442.096424323003;2448.3511869354634;2453.0678342229926;2394.353524548371;2395.66460695501;2416.7704068113503;2423.0792298926385;2425.3815277104227;2375.3586531636533;2388.689470368841;2393.258089992108;2394.437307232799;2403.579373609611;9108.59011344491;9128.634854605807;9210.171084602418;9227.769305767342;9239.49182794946;5169.767360468751;5347.759350829222;5500.642458240201;5518;5558.055130627763;3469.4275444551618;3583.3549961007006;3796.2597293527774;3807.676347510437;3819.026148332185;925.5511077127587;1106.9612563560236;1109.2457129152174;1112.883147269533;1116.5980247111033;12086.576969806103;12142.45358958849;12175.147739658227;12207.816882746765;12245;4747.454042785055;4797.688150270221;4800.927986080212;4902.48523904992;4934.432540257844;10231.897681023243;10291.691249262534;10295.794084118426;10333.22500812442;10335.534900929477;5172.741362931838;5435.912817436529;5440.265564148868;5442.8911421771345;5463.863403414946;4484.080763443486;4829.975850120797;4942.579880710108;4975.850724478271;5011.674241174312;3939.881803545898;3983.2830090583393;4045.5752146024834;4100.118474527991;4100.7334523255895;1308.0778051473687;1308.6205000549924;1317.1701827848394;1324.8079028541001;1335.7395307915058;814.9877751833727;867.1761826265074;884.7036242858586;931.9860202096974;935.1524607569966;5470.699111548824;5721.628094173949;5897.734601942923;6042.244719410074;6087.969560152171;424.06282116522215;429.7979949423766;431.488685907201;433.3954133983076;458.6560079940045;3914.1054650622814;3933.704972127102;4013.3177359848896;4029.3754468056914;4076.510818701775;10699.25105242641;11031.448427578589;11085.334879907232;11105.278156919774;11127.332360058423;8435.578221088921;9300.976892541816;10698.465076746288;11031;11223.382713950648;7038;8386.580670966427;8436.36727245459;8506.97916250054;8508.446950948168;5040.6471546992825;5647.265855438766;5823.563232757476;5862.062070068769;5915.645061296336;10175.84736228972;10204.540795664065;10263.025012624088;10269.537870795682;10295.7426064346;10118.6458473956;10252.128569071712;10412.947935260578;10432.374057556572;10532;6928.618925959121;7444.590547519939;7473.88789168152;7639.274268944441;7693.884591731016;8510.957445212734;8589.613467393858;8608.139186081342;8612.18184272493;8650.43772154808;7583.696652133853;7597.810054748676;7629.046369203849;7682.154962954182;7838.294553490213;7334.523255988343;7424.888626670496;7504.137024242282;7541.132769731551;7593.620318983918;6972.372486476242;7076.681549330189;7094.255103214088;7096.680649370894;7105.6447177639875;4916.311716359784;5064.34163558735;5113.51421614946;5113.565346945551;5133.79464821403;4291.9913820251595;4978.960038996143;5107.974460127675;5162.354705661793;5234.555062819703 14:27:58 INFO - PROCESS | 2010 | |4;prototype.html;266.3909983698461;298.1681109703926;309.76148365758365;313.87131276176774;315.70323895538195;5341.999999999995;5478.369987451444;5573.7704918032705;5685.204071429998;5765.38569200624;5081.212412076134;5253.4221235664045;5387.841614052978;5628.577856660746;5672.17753425753;3953.655757042605;3971.458266709308;4334.98718390717;4336.4362632857765;4381.18947994622;4178.749275043492;4201.256478561409;4259.70182087254;4318.892027699301;4355.802154407547;4255.872323830275;4267.167902259061;4278.35824626307;4281.764502952336;4283.67872409569;3883.689304855619;3977.6817854571564;4185.686073544496;4256.851010214658;4265.658747300208;3177.855971850132;3197.600299962505;3223.5171820962387;3277.328562433176;3500.6149323574386;5240.764165612519;5295.655782374133;5480.492864462305;5528.760851855005;5545.445455454423;4141.0330093205785;4937.111319962405;4942.085714142859;4970.881551650886;4974.825881094144;5211.062008838408;5500.42245564218;5812.418758124196;5986.760529578812;6025.548083893682;3958.782266975315;3988;3992.86024989124;4015.0489390298108;4037.959620403817;6288.798920377877;6304.464120549759;6384.403899025244;6398.2641996170105;6425.068365087036;3910.9413358799643;4016.5581786003518;4038.8990275243355;4056.3915412688334;4094.815733292009;3468.5952189363347;4167.666346769065;4254.446921900133;4270.658347332206;4271.722338048017;4981.178105612606;4989.950100499022;4993.1262029144755;5017.8243761468175;5032.32063671407;4955.801767929314;5457.345118585795;6024.0662697282;6068.419632416895;6073.240844894388;1432.3124900047826;1466.4500812195427;1469.2359972814077;1472.63184203949;1481.8221813382463;784.5920121536769;849.7153453592992;860.9956950215209;878.6924576398337;920.8857282687889;4102.835886564504;4122.793860306972;4345.9348109778375;4445;4707.5057119002695;4706.882327941828;4997.6770093868545;5209.359051898716;5223.138182199895;5234.424213336606;4099.344104943195;4356.782160891943;4539.682222244477;4550.087943716025;4600.722642292087;2962.3630919352013;3027.2583217111946;3232.6282477514915;3239.6436391996863;3282.6365017187586;5725.969325521362;6313.2424109107205;6320.4311611955145;6391.904121438182;6401;5254.448282930237;6022.397760223943;6290.816606956414;6328.493720502441;6357.586756860789;5553.777848885999;5947.583669143119;6359.777407790612;6361.201071528512;6382.840428989312;4928.186849169847;4947.45577986414;6121.173641558511;6172.722227499863;6172.783952561639;5445.727713614383;5929.6145750526075;6007.459328660441;6025.216721826135;6030.185924900083;5377.623566350318;5402.189671549299;5417.918731218956;5429.344050064768;6495.271985765895;3548.361294966931;3615.2588719311952;3738.971433139166;3985.880423587181;4059.6549293309217;6070.848228794315;6132.877342453036;6164.116606537852;6175.752969881334;6256.812295630956;5069.340985671839;5732.226149469769;5953.434423729739;5965.8679193423795;5981.491573216325;5871.236739224044;5874.676892770768;5889.175515427929;5891.499222565958;5955.171293635489;5619.719014049363;5794.159846822272;5809.24479817621;5819.082874970643;5835.824925252249;4573.896007836433;5597.720113994365;5637.661740295595;5699.800506982401;5762.654240745569;5139.357580302462;5165.199394093921;5786.479216870502;5807.157962095388;5850.619709718854 14:27:58 INFO - PROCESS | 2010 | |5;yui.html;691.2258270736774;708.1077841919181;766.004194547089;775.209286527742;802.7993001749562;14889.627759306022;15881.920590397061;15891.841081589195;15944.840551594481;15951.680966380665;14287.857121428782;14355;14487.782683259733;14514.201718905457;14526.418943242257;676.5298117808126;834.253343257784;852.071242345843;867.1588559097665;877.6401675313123;851.8040850604365;863.2705363967438;866.5883705239992;867.3061550759368;868.1708967935606;882.5587206396801;919.4483310014004;923.2291036984126;925.2320573923661;926.1479438916214;904.3624244907357;919.7286800393833;919.7608621758358;921.0513171433435;923.6351641101761;643.4369926314475;675.368530424055;685.3626127701236;686.584616307132;686.8557602903396;12105.455254513568;12373.69065773354;12467.625971220878;12556.121071524996;14117.929410352883;11857.762844743143;14293.928530357385;14337.28313584327;14414.351354188982;14663.34014969329;11916.582919597773;11938.22401543897;11986.940065299617;12138.939305303416;12164.878351216463;3234.5956755405573;3850.614938506155;3897.902552436183;4009.7393669411395;4020.577839326858;107448.92551074545;114108.42945785301;114229.38710321471;114544.28183577253;127017;9861.964493728055;11220;11342.773144537063;11364.829527557093;11380.260283081574;22795.88602056979;23464.06143754265;23492.412689682555;23504.294871153892;23532.411689707893;8058.597070146469;8061.596920153969;8130.796730081795;8307.750767476986;8403.537805420761;4496.595306422438;4516;4568.086382723469;4585.633149348111;4659.790309436084;3583.480395342661;3713.814309284579;3713.8885833425043;3714.758540694846;3717.6096509866616;579.273012369482;579.3511267380477;593.403629352498;601.2064075420403;612.5497759147023;590.7636945221859;602.7046747093892;630.4011189370117;676.972921083161;690.8134803602999;8734.956325218332;9423.293253005915;9560.996095409882;9570.808583828284;9644.228461723185;564.6781334639298;565.3667891960948;628.8176428835586;685.7709961543233;695.7043256615918;3947.1513624570857;4295.806688699016;4638.257878739453;4724.858254252378;4771.355866957986;94104;122930;141336;144252;154902;108981.91018089876;111237;111399;111786;118347;86003.13996859951;104354.47822760837;107080.60512528475;108543.45728271308;109712;8194.631241594023;8659.783505412415;9145.862812057958;9937.304388693012;10054.245931555017;59962;60947.390526095944;61765.691171543855;62368;63526.04710929247;75072.1174276693;85255.1474485272;96788;98771.5061424717;99481;12585.496580137058;12673.17624354414;12966.870331296566;13006.959443244328;13035.47858085704;14570.562883113524;14605.634859128606;14743.041702289316;14826.925865370604;14834.554963351116;13398.196108233147;13617.210902879055;13621.591352259447;13707.177569345871;14312.642183945069;13648.65878353049;13691;14092.78860817068;14145.858541414455;14399.280035997948;10885.619003334845;13439.46242150303;13494.122882012638;13626.250556219107;13762.036657433884;11157.66527004191;11228.52776768431;11233.606823761129;11316.94341528287;11448;9978.401295922267;10495.265331426726;11324.263922844988;11346.94326528362;11566.016888564567 14:27:58 INFO - PROCESS | 2010 | __end_tp_report 14:27:58 INFO - PROCESS | 2010 | __start_cc_report 14:27:58 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,380 14:27:58 INFO - PROCESS | 2010 | __end_cc_report 14:27:58 INFO - PROCESS | 2010 | __startTimestamp1472765278893__endTimestamp 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | ------- Summary: start ------- 14:27:58 INFO - PROCESS | 2010 | Number of tests: 6 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#0] dojo.html Cycles:165 Average:5642.18 Median:5804.48 stddev:662.57 (11.4%) stddev-sans-first:635.20 14:27:58 INFO - PROCESS | 2010 | Values: 3154.2 3335.7 3343.9 3373.3 3408.4 4879.8 4897.8 5584.0 5594.8 5655.1 4984.7 5272.1 5496.2 5643.5 5671.7 4350.5 5132.1 5144.5 5260.2 5261.0 5135.9 5349.9 5376.9 5382.1 5382.7 5114.7 5217.6 5236.7 5265.2 5298.4 5142.4 5210.5 5218.3 5240.1 5248.0 5116.9 5149.1 5174.3 5181.4 5182.1 5495.5 5506.1 5525.4 5584.2 5692.1 6103.0 6113.5 6155.0 6193.6 6206.2 6209.2 6226.0 6234.2 6235.8 6259.8 4476.7 4694.8 5174.6 5698.2 5751.1 5435.4 5604.5 6030.2 6263.4 6300.4 5551.3 5707.8 6093.9 6105.0 6119.4 6045.8 6120.3 6192.4 6231.2 6246.4 5597.7 6124.8 6138.1 6203.1 6230.1 5760.4 6136.8 6176.9 6207.8 6207.8 4780.3 4850.4 4884.6 4887.5 4890.9 4268.7 4346.2 4360.7 4407.3 4424.1 5724.9 5751.3 5752.6 5760.3 5771.5 6019.1 6073.4 6242.7 6267.0 6272.6 5005.8 5780.2 5804.5 5816.1 5860.0 5386.1 5407.7 5414.2 5425.1 5429.9 6190.3 6195.7 6215.6 6293.9 6299.9 6142.8 6238.6 6243.6 6251.0 6253.7 6264.6 6267.8 6284.4 6289.2 6334.1 5122.9 6114.3 6134.6 6135.4 6155.6 6081.1 6145.8 6221.8 6224.7 6232.0 6096.8 6101.0 6119.2 6120.8 6128.4 5937.5 6023.8 6096.5 6111.4 6113.3 4781.8 5719.8 5912.5 5955.7 6039.6 6062.0 6096.9 6105.5 6109.9 6112.2 5782.9 5887.4 5896.8 5904.8 5910.9 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#1] ext.html Cycles:180 Average:65508.22 Median:22020.98 stddev:140289.21 (637.1%) stddev-sans-first:140597.91 14:27:58 INFO - PROCESS | 2010 | Values: 523.1 540.6 541.3 543.0 579.8 38501.8 41165.6 41170.6 41190.8 41346.4 41796.8 42070.6 42300.0 42333.6 42501.7 9648.7 9845.7 9857.0 9897.7 9903.2 8404.4 8461.0 9911.0 9940.0 9969.6 8674.9 9818.4 9892.5 9913.3 9943.3 9838.3 9870.0 9891.3 9962.5 9966.0 8128.5 9099.0 9275.7 9309.9 9370.1 40540.2 40672.6 40988.0 41260.8 41312.8 3340.2 3420.5 3591.5 3854.7 4055.0 30910.8 31042.8 31149.4 31204.9 31300.7 3271.5 3280.0 3294.0 3299.8 3365.5 473335.0 474472.0 474644.0 476580.0 477812.0 60083.7 60317.0 60475.0 60557.7 60589.0 34329.3 34715.3 35580.0 35966.3 64243.7 16611.0 16783.7 16803.0 16804.9 16837.2 12732.3 12850.6 12852.8 12872.5 12906.5 18610.5 18623.4 18916.7 18953.3 18972.7 7931.6 8086.7 8103.3 8170.3 8329.2 895.9 947.6 1013.5 1069.6 1074.4 26886.9 29344.9 30406.8 30844.4 31007.4 966.9 1048.5 1075.1 1077.3 1137.7 12186.5 15878.8 15884.4 16196.0 16198.6 583677.0 585649.0 587932.0 589702.1 590177.0 41794.2 42149.4 42216.0 42311.6 42418.8 1351.9 1365.7 1394.4 1397.0 1399.4 24683.0 25730.2 29438.0 29515.6 29994.9 51615.7 51616.7 51737.7 51798.7 51802.2 504838.0 508514.0 510756.0 511493.4 511962.0 26440.5 26610.9 26862.2 26877.9 26902.7 46565.7 46816.3 47250.3 47272.5 47833.3 38214.6 38970.6 38976.6 39278.2 39351.4 38804.8 38831.8 38868.6 39777.6 39987.0 37290.3 37925.7 38402.6 38496.0 38767.0 27418.9 33823.0 34559.7 34801.7 34900.0 21637.6 23691.0 24590.8 25315.5 26289.5 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#2] jquery.html Cycles:180 Average:31988.57 Median:2588.47 stddev:89422.42 (3454.6%) stddev-sans-first:89641.71 14:27:58 INFO - PROCESS | 2010 | Values: 345.9 361.9 371.5 378.6 394.6 19202.9 19413.0 19742.8 20585.0 20643.8 19243.9 19282.9 19326.7 19514.8 19633.8 5006.5 5648.5 5888.7 5902.5 5907.8 5874.6 6018.7 6034.6 6047.4 6051.9 5641.3 5753.2 5942.5 5988.0 5999.7 5714.3 5765.6 5805.9 5821.7 5841.7 5061.2 5071.6 5077.4 5356.9 5418.3 12530.2 12534.1 12682.2 12723.0 12724.0 2251.7 2255.9 2357.6 2819.3 2864.9 9552.0 9679.3 9942.6 10001.6 14017.9 1718.2 1767.7 1777.6 1802.2 1829.4 103193.5 109891.0 109895.0 109947.0 110004.0 10607.5 10758.4 10879.5 11115.8 11197.9 13515.9 13618.1 13633.0 13652.0 13684.0 6491.4 8301.5 8317.1 8369.0 8369.9 8152.7 8278.7 8299.7 8395.4 8460.7 4198.6 4233.2 4293.0 4349.2 4410.9 1746.0 1852.1 1873.2 1903.3 1913.4 811.7 861.2 904.9 905.5 909.2 15420.5 18475.9 19823.9 20066.5 20257.4 888.4 922.7 925.9 952.2 1001.4 10079.1 10314.4 10362.0 10388.7 10411.4 471742.0 545229.0 547594.8 550002.0 552483.0 90679.5 113796.4 118076.4 129025.4 133162.0 987.0 996.7 1044.1 1044.7 1054.6 16108.4 16487.3 18000.1 18069.9 18448.5 50256.5 52151.0 53653.5 54268.5 54283.7 74324.6 77409.2 77470.6 77477.0 78532.2 6623.8 7445.0 7793.9 7915.4 8075.7 11538.8 11977.5 12346.3 12541.0 12559.7 9588.6 10806.6 10918.2 10957.7 11163.3 10651.6 10824.2 10908.7 11115.8 11205.0 11025.3 11092.9 11336.3 11468.2 11470.9 5888.5 6737.1 7732.3 7788.3 8104.8 9324.5 10847.3 10924.9 10973.6 11013.6 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#3] mootools.html Cycles:180 Average:5785.84 Median:4799.31 stddev:3281.18 (68.4%) stddev-sans-first:3274.53 14:27:58 INFO - PROCESS | 2010 | Values: 1494.3 1521.6 1715.2 1804.7 1833.3 7182.8 8154.5 8599.8 9208.5 9237.4 7688.9 9030.7 9049.7 9053.5 9067.1 2371.8 2423.7 2424.8 2425.6 2426.9 2400.6 2417.2 2447.3 2450.8 2456.7 2426.7 2432.2 2442.1 2448.4 2453.1 2394.4 2395.7 2416.8 2423.1 2425.4 2375.4 2388.7 2393.3 2394.4 2403.6 9108.6 9128.6 9210.2 9227.8 9239.5 5169.8 5347.8 5500.6 5518.0 5558.1 3469.4 3583.4 3796.3 3807.7 3819.0 925.6 1107.0 1109.2 1112.9 1116.6 12086.6 12142.5 12175.1 12207.8 12245.0 4747.5 4797.7 4800.9 4902.5 4934.4 10231.9 10291.7 10295.8 10333.2 10335.5 5172.7 5435.9 5440.3 5442.9 5463.9 4484.1 4830.0 4942.6 4975.9 5011.7 3939.9 3983.3 4045.6 4100.1 4100.7 1308.1 1308.6 1317.2 1324.8 1335.7 815.0 867.2 884.7 932.0 935.2 5470.7 5721.6 5897.7 6042.2 6088.0 424.1 429.8 431.5 433.4 458.7 3914.1 3933.7 4013.3 4029.4 4076.5 10699.3 11031.4 11085.3 11105.3 11127.3 8435.6 9301.0 10698.5 11031.0 11223.4 7038.0 8386.6 8436.4 8507.0 8508.4 5040.6 5647.3 5823.6 5862.1 5915.6 10175.8 10204.5 10263.0 10269.5 10295.7 10118.6 10252.1 10412.9 10432.4 10532.0 6928.6 7444.6 7473.9 7639.3 7693.9 8511.0 8589.6 8608.1 8612.2 8650.4 7583.7 7597.8 7629.0 7682.2 7838.3 7334.5 7424.9 7504.1 7541.1 7593.6 6972.4 7076.7 7094.3 7096.7 7105.6 4916.3 5064.3 5113.5 5113.6 5133.8 4292.0 4979.0 5108.0 5162.4 5234.6 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#4] prototype.html Cycles:180 Average:4715.88 Median:5210.21 stddev:1474.68 (28.3%) stddev-sans-first:1440.50 14:27:58 INFO - PROCESS | 2010 | Values: 266.4 298.2 309.8 313.9 315.7 5342.0 5478.4 5573.8 5685.2 5765.4 5081.2 5253.4 5387.8 5628.6 5672.2 3953.7 3971.5 4335.0 4336.4 4381.2 4178.7 4201.3 4259.7 4318.9 4355.8 4255.9 4267.2 4278.4 4281.8 4283.7 3883.7 3977.7 4185.7 4256.9 4265.7 3177.9 3197.6 3223.5 3277.3 3500.6 5240.8 5295.7 5480.5 5528.8 5545.4 4141.0 4937.1 4942.1 4970.9 4974.8 5211.1 5500.4 5812.4 5986.8 6025.5 3958.8 3988.0 3992.9 4015.0 4038.0 6288.8 6304.5 6384.4 6398.3 6425.1 3910.9 4016.6 4038.9 4056.4 4094.8 3468.6 4167.7 4254.4 4270.7 4271.7 4981.2 4990.0 4993.1 5017.8 5032.3 4955.8 5457.3 6024.1 6068.4 6073.2 1432.3 1466.5 1469.2 1472.6 1481.8 784.6 849.7 861.0 878.7 920.9 4102.8 4122.8 4345.9 4445.0 4707.5 4706.9 4997.7 5209.4 5223.1 5234.4 4099.3 4356.8 4539.7 4550.1 4600.7 2962.4 3027.3 3232.6 3239.6 3282.6 5726.0 6313.2 6320.4 6391.9 6401.0 5254.4 6022.4 6290.8 6328.5 6357.6 5553.8 5947.6 6359.8 6361.2 6382.8 4928.2 4947.5 6121.2 6172.7 6172.8 5445.7 5929.6 6007.5 6025.2 6030.2 5377.6 5402.2 5417.9 5429.3 6495.3 3548.4 3615.3 3739.0 3985.9 4059.7 6070.8 6132.9 6164.1 6175.8 6256.8 5069.3 5732.2 5953.4 5965.9 5981.5 5871.2 5874.7 5889.2 5891.5 5955.2 5619.7 5794.2 5809.2 5819.1 5835.8 4573.9 5597.7 5637.7 5699.8 5762.7 5139.4 5165.2 5786.5 5807.2 5850.6 14:27:58 INFO - PROCESS | 2010 | 14:27:58 INFO - PROCESS | 2010 | [#5] yui.html Cycles:180 Average:23864.56 Median:3714.32 stddev:37104.25 (999.0%) stddev-sans-first:37167.54 14:27:58 INFO - PROCESS | 2010 | Values: 691.2 708.1 766.0 775.2 802.8 14889.6 15881.9 15891.8 15944.8 15951.7 14287.9 14355.0 14487.8 14514.2 14526.4 676.5 834.3 852.1 867.2 877.6 851.8 863.3 866.6 867.3 868.2 882.6 919.4 923.2 925.2 926.1 904.4 919.7 919.8 921.1 923.6 643.4 675.4 685.4 686.6 686.9 12105.5 12373.7 12467.6 12556.1 14117.9 11857.8 14293.9 14337.3 14414.4 14663.3 11916.6 11938.2 11986.9 12138.9 12164.9 3234.6 3850.6 3897.9 4009.7 4020.6 107448.9 114108.4 114229.4 114544.3 127017.0 9862.0 11220.0 11342.8 11364.8 11380.3 22795.9 23464.1 23492.4 23504.3 23532.4 8058.6 8061.6 8130.8 8307.8 8403.5 4496.6 4516.0 4568.1 4585.6 4659.8 3583.5 3713.8 3713.9 3714.8 3717.6 579.3 579.4 593.4 601.2 612.5 590.8 602.7 630.4 677.0 690.8 8735.0 9423.3 9561.0 9570.8 9644.2 564.7 565.4 628.8 685.8 695.7 3947.2 4295.8 4638.3 4724.9 4771.4 94104.0 122930.0 141336.0 144252.0 154902.0 108981.9 111237.0 111399.0 111786.0 118347.0 86003.1 104354.5 107080.6 108543.5 109712.0 8194.6 8659.8 9145.9 9937.3 10054.2 59962.0 60947.4 61765.7 62368.0 63526.0 75072.1 85255.1 96788.0 98771.5 99481.0 12585.5 12673.2 12966.9 13007.0 13035.5 14570.6 14605.6 14743.0 14826.9 14834.6 13398.2 13617.2 13621.6 13707.2 14312.6 13648.7 13691.0 14092.8 14145.9 14399.3 10885.6 13439.5 13494.1 13626.3 13762.0 11157.7 11228.5 11233.6 11316.9 11448.0 9978.4 10495.3 11324.3 11346.9 11566.0 14:27:58 INFO - PROCESS | 2010 | -------- Summary: end -------- 14:27:58 INFO - PROCESS | 2010 | 14:27:59 INFO - TEST-INFO | 2010: exit 0 14:27:59 INFO - TEST-OK | dromaeo_css | took 1113573ms 14:27:59 INFO - TEST-START | kraken 14:27:59 INFO - operating with platform_type : mac_ 14:27:59 INFO - Initialising browser for kraken test... 14:27:59 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzUOOUE/profile http://localhost:49375/getInfo.html) 14:28:02 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 14:28:02 INFO - PROCESS | 2016 | colorDepth:24 14:28:02 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 14:28:02 INFO - PROCESS | 2016 | __metrics 14:28:02 ERROR - PROCESS | 2016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 14:28:03 INFO - TEST-INFO | 2016: exit 0 14:28:03 INFO - Browser initialized. 14:28:03 INFO - Running cycle 1/1 for kraken test... 14:28:03 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzUOOUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:15 INFO - PROCESS | 2018 | RSS: Main: 244994048 14:28:15 INFO - PROCESS | 2018 | 14:28:17 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:18 INFO - PROCESS | 2018 | RSS: Main: 258056192 14:28:18 INFO - PROCESS | 2018 | 14:28:21 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-dft) 14:28:22 INFO - PROCESS | 2018 | RSS: Main: 266870784 14:28:22 INFO - PROCESS | 2018 | 14:28:25 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-fft) 14:28:26 INFO - PROCESS | 2018 | RSS: Main: 264495104 14:28:26 INFO - PROCESS | 2018 | 14:28:28 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator) 14:28:28 INFO - PROCESS | 2018 | RSS: Main: 266801152 14:28:28 INFO - PROCESS | 2018 | 14:28:30 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:31 INFO - PROCESS | 2018 | RSS: Main: 267268096 14:28:31 INFO - PROCESS | 2018 | 14:28:34 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:34 INFO - PROCESS | 2018 | RSS: Main: 267939840 14:28:34 INFO - PROCESS | 2018 | 14:28:37 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:38 INFO - PROCESS | 2018 | RSS: Main: 267923456 14:28:38 INFO - PROCESS | 2018 | 14:28:41 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial) 14:28:42 INFO - PROCESS | 2018 | RSS: Main: 268165120 14:28:42 INFO - PROCESS | 2018 | 14:28:43 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:44 INFO - PROCESS | 2018 | RSS: Main: 268132352 14:28:44 INFO - PROCESS | 2018 | 14:28:46 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:47 INFO - PROCESS | 2018 | RSS: Main: 268308480 14:28:47 INFO - PROCESS | 2018 | 14:28:49 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:50 INFO - PROCESS | 2018 | RSS: Main: 268570624 14:28:50 INFO - PROCESS | 2018 | 14:28:52 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:53 INFO - PROCESS | 2018 | RSS: Main: 268861440 14:28:53 INFO - PROCESS | 2018 | 14:28:56 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:57 INFO - PROCESS | 2018 | RSS: Main: 268931072 14:28:57 INFO - PROCESS | 2018 | 14:28:58 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49375/tests/kraken/driver.html?testName=ai-astar) 14:28:59 INFO - PROCESS | 2018 | RSS: Main: 270925824 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | __start_tp_report 14:28:59 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 14:28:59 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 14:28:59 INFO - PROCESS | 2018 | |i|pagename|runs| 14:28:59 INFO - PROCESS | 2018 | |0;ai-astar;118;113;117;117;117;102;116;127;161;117 14:28:59 INFO - PROCESS | 2018 | |1;audio-beat-detection;151;111;122;156;125;171;162;142;159;111 14:28:59 INFO - PROCESS | 2018 | |2;audio-dft;202;212;217;232;268;203;201;201;200;193 14:28:59 INFO - PROCESS | 2018 | |3;audio-fft;67;84;80;143;59;59;62;64;133;60 14:28:59 INFO - PROCESS | 2018 | |4;audio-oscillator;70;72;117;71;70;90;113;69;75;109 14:28:59 INFO - PROCESS | 2018 | |5;imaging-gaussian-blur;128;88;102;130;90;89;92;89;91;90 14:28:59 INFO - PROCESS | 2018 | |6;imaging-darkroom;98;152;96;95;98;96;98;151;96;96 14:28:59 INFO - PROCESS | 2018 | |7;imaging-desaturate;81;151;141;92;89;90;91;100;93;95 14:28:59 INFO - PROCESS | 2018 | |8;json-parse-financial;54;58;57;57;58;67;83;87;86;58 14:28:59 INFO - PROCESS | 2018 | |9;json-stringify-tinderbox;69;103;71;66;78;106;69;99;63;92 14:28:59 INFO - PROCESS | 2018 | |10;stanford-crypto-aes;85;87;89;88;113;110;87;86;89;86 14:28:59 INFO - PROCESS | 2018 | |11;stanford-crypto-ccm;158;150;140;138;139;138;141;142;182;146 14:28:59 INFO - PROCESS | 2018 | |12;stanford-crypto-pbkdf2;171;171;169;173;176;171;172;170;169;169 14:28:59 INFO - PROCESS | 2018 | |13;stanford-crypto-sha256-iterative;68;69;70;68;67;69;67;71;87;88 14:28:59 INFO - PROCESS | 2018 | __end_tp_report 14:28:59 INFO - PROCESS | 2018 | __start_cc_report 14:28:59 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,959 14:28:59 INFO - PROCESS | 2018 | __end_cc_report 14:28:59 INFO - PROCESS | 2018 | __startTimestamp1472765339065__endTimestamp 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | ------- Summary: start ------- 14:28:59 INFO - PROCESS | 2018 | Number of tests: 14 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#0] ai-astar Cycles:10 Average:120.50 Median:117.00 stddev:15.48 (13.2%) stddev-sans-first:16.39 14:28:59 INFO - PROCESS | 2018 | Values: 118.0 113.0 117.0 117.0 117.0 102.0 116.0 127.0 161.0 117.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:153.50 stddev:22.13 (14.4%) stddev-sans-first:23.18 14:28:59 INFO - PROCESS | 2018 | Values: 151.0 111.0 122.0 156.0 125.0 171.0 162.0 142.0 159.0 111.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#2] audio-dft Cycles:10 Average:212.90 Median:207.50 stddev:22.31 (10.8%) stddev-sans-first:23.32 14:28:59 INFO - PROCESS | 2018 | Values: 202.0 212.0 217.0 232.0 268.0 203.0 201.0 201.0 200.0 193.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#3] audio-fft Cycles:10 Average:81.10 Median:63.00 stddev:31.29 (49.7%) stddev-sans-first:32.77 14:28:59 INFO - PROCESS | 2018 | Values: 67.0 84.0 80.0 143.0 59.0 59.0 62.0 64.0 133.0 60.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:70.50 stddev:19.93 (28.3%) stddev-sans-first:20.33 14:28:59 INFO - PROCESS | 2018 | Values: 70.0 72.0 117.0 71.0 70.0 90.0 113.0 69.0 75.0 109.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:89.50 stddev:16.35 (18.3%) stddev-sans-first:13.54 14:28:59 INFO - PROCESS | 2018 | Values: 128.0 88.0 102.0 130.0 90.0 89.0 92.0 89.0 91.0 90.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:96.00 stddev:23.16 (24.1%) stddev-sans-first:24.31 14:28:59 INFO - PROCESS | 2018 | Values: 98.0 152.0 96.0 95.0 98.0 96.0 98.0 151.0 96.0 96.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#7] imaging-desaturate Cycles:10 Average:102.30 Median:90.50 stddev:23.64 (26.1%) stddev-sans-first:23.79 14:28:59 INFO - PROCESS | 2018 | Values: 81.0 151.0 141.0 92.0 89.0 90.0 91.0 100.0 93.0 95.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:62.50 stddev:13.44 (21.5%) stddev-sans-first:13.48 14:28:59 INFO - PROCESS | 2018 | Values: 54.0 58.0 57.0 57.0 58.0 67.0 83.0 87.0 86.0 58.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#9] json-stringify-tinderbox Cycles:10 Average:81.60 Median:70.00 stddev:16.65 (23.8%) stddev-sans-first:17.03 14:28:59 INFO - PROCESS | 2018 | Values: 69.0 103.0 71.0 66.0 78.0 106.0 69.0 99.0 63.0 92.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:87.00 stddev:10.38 (11.9%) stddev-sans-first:10.70 14:28:59 INFO - PROCESS | 2018 | Values: 85.0 87.0 89.0 88.0 113.0 110.0 87.0 86.0 89.0 86.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:144.00 stddev:13.70 (9.5%) stddev-sans-first:13.99 14:28:59 INFO - PROCESS | 2018 | Values: 158.0 150.0 140.0 138.0 139.0 138.0 141.0 142.0 182.0 146.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 14:28:59 INFO - PROCESS | 2018 | Values: 171.0 171.0 169.0 173.0 176.0 171.0 172.0 170.0 169.0 169.0 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - PROCESS | 2018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:69.50 stddev:8.06 (11.6%) stddev-sans-first:8.39 14:28:59 INFO - PROCESS | 2018 | Values: 68.0 69.0 70.0 68.0 67.0 69.0 67.0 71.0 87.0 88.0 14:28:59 INFO - PROCESS | 2018 | -------- Summary: end -------- 14:28:59 INFO - PROCESS | 2018 | 14:28:59 INFO - TEST-INFO | 2018: exit 0 14:28:59 INFO - TEST-OK | kraken | took 60432ms 14:28:59 INFO - SUITE-END | took 1174s 14:29:00 INFO - Completed test suite (00:19:34) 14:29:00 INFO - javascript benchmark 14:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7284.013186257311, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.1956801015735, 3335.7331413486922, 3343.933121337575, 3373.3084717632887, 3408.403529382358, 4879.780409881555, 4897.828575999841, 5583.972080139599, 5594.804181853636, 5655.066913959192, 4984.6541433812845, 5272.1300985337375, 5496.230527726121, 5643.463870932265, 5671.744771485282, 4350.54319296474, 5132.076226279269, 5144.536991670759, 5260.237265596486, 5260.974110048542, 5135.922961155567, 5349.866253343658, 5376.892462150755, 5382.058139825534, 5382.703951282678, 5114.718690472023, 5217.5565076968505, 5236.7119808410525, 5265.236540701615, 5298.4436634153435, 5142.434332223453, 5210.505002024802, 5218.269442278046, 5240.135377662681, 5247.9737601311745, 5116.923246151311, 5149.0989076911765, 5174.275601415805, 5181.35233095863, 5182.144946083929, 5495.516210623109, 5506.146547285177, 5525.419830917736, 5584.246126772874, 5692.146178073281, 6102.974033066861, 6113.480354169901, 6154.984427569446, 6193.566450348478, 6206.162168107293, 6209.16176316196, 6226.0, 6234.18955535782, 6235.781747638856, 6259.843503912393, 4476.664250181184, 4694.765261736899, 5174.61190410717, 5698.202251684767, 5751.079827227665, 5435.429279925551, 5604.495595396353, 6030.185924900083, 6263.404976527223, 6300.432961033529, 5551.278333816578, 5707.800226992118, 6093.908591371133, 6105.0, 6119.418655227746, 6045.818625441156, 6120.325235636551, 6192.380761923861, 6231.189945307172, 6246.3753624637175, 5597.74810133545, 6124.846878828065, 6138.112525404923, 6203.100550420254, 6230.065490176419, 5760.36635970043, 6136.846578835565, 6176.907346389808, 6207.782727604512, 6207.844803879849, 4780.330753694486, 4850.393700787402, 4884.5603895649565, 4887.535684110004, 4890.853274401774, 4268.701190916606, 4346.195953748504, 4360.716553424018, 4407.2507673695545, 4424.093060922503, 5724.856878578069, 5751.309842818889, 5752.568557358215, 5760.337561180434, 5771.538276937835, 6019.127226552126, 6073.362296958844, 6242.65665388408, 6266.968665156736, 6272.6236425814595, 5005.824796132118, 5780.16187652788, 5804.4775970162045, 5816.098504731774, 5860.0, 5386.057439948072, 5407.675539467645, 5414.187871819258, 5425.050616142238, 5429.945700542944, 6190.319064902767, 6195.690215489118, 6215.595986260879, 6293.937060629335, 6299.937000630027, 6142.836439233887, 6238.563300568917, 6243.594166379171, 6250.968590182751, 6253.749850006131, 6264.624122552661, 6267.780627678009, 6284.402981716912, 6289.182406287154, 6334.113224148531, 5122.871928201825, 6114.266288045463, 6134.601250918676, 6135.386461354007, 6155.630662160284, 6081.087836824512, 6145.754169833157, 6221.813345599639, 6224.657643829632, 6232.034034724625, 6096.775321244162, 6101.023836186189, 6119.173911522065, 6120.782376608402, 6128.411459112376, 5937.524998000236, 6023.789167379296, 6096.514080138941, 6111.419415155553, 6113.2969708482315, 4781.760911954458, 5719.798842243175, 5912.46787789101, 5955.731992060454, 6039.63762174271, 6061.969690151521, 6096.8780624388155, 6105.481034111973, 6109.938900610937, 6112.235970503687, 5782.942170578241, 5887.352391236875, 5896.7936122235515, 5904.822855314347, 5910.940890591039], "value": 5600.984578397125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.068937291621, 540.5675459632293, 541.2638811216746, 542.9755660995255, 579.8086631411635, 38501.80749096254, 41165.58834411655, 41170.588294117086, 41190.79404602977, 41346.37980430296, 41796.791016044874, 42070.57929420705, 42300.0, 42333.57666423335, 42501.724948251525, 9648.71053868385, 9845.704628861109, 9857.014298570122, 9897.723523589579, 9903.207743380548, 8404.369672274574, 8461.0, 9911.0, 9940.0, 9969.601215951354, 8674.86987695185, 9818.361806482591, 9892.5161225816, 9913.256505762061, 9943.303968722192, 9838.311318207656, 9870.012998700144, 9891.258155638356, 9962.501874906298, 9965.950170249174, 8128.512289262663, 9098.954505227432, 9275.67535136267, 9309.860352094724, 9370.10983956523, 40540.189196216204, 40672.59327406718, 40988.0, 41260.79369603133, 41312.79343603293, 3340.2150494633743, 3420.504026916108, 3591.5331006969186, 3854.6530812227033, 4054.9594504054876, 30910.845445772626, 31042.844785776153, 31149.377012459623, 31204.907828225903, 31300.686993130006, 3271.492918597621, 3279.9836000820083, 3293.950590741141, 3299.7525185611175, 3365.5456513370627, 473335.0, 474472.0, 474644.0, 476580.0, 477812.0, 60083.699581501816, 60317.0, 60475.0, 60557.69721151454, 60589.0, 34329.31341373159, 34715.30569388598, 35580.0, 35966.280674386886, 64243.67878160673, 16611.0, 16783.664326713642, 16803.0, 16804.915975420045, 16837.158142092845, 12732.29972351511, 12850.55023074188, 12852.807207891889, 12872.485100596059, 12906.548270810477, 18610.534736631693, 18623.44129676112, 18916.71624925627, 18953.336633217772, 18972.715409268872, 7931.56376399292, 8086.706127019766, 8103.270705636521, 8170.264676179172, 8329.167083291744, 895.8880139982502, 947.5641205045619, 1013.5439052426437, 1069.6149386220955, 1074.409075008742, 26886.865565672048, 29344.853275733483, 30406.84796576003, 30844.383112337626, 31007.379852403275, 966.8791401074866, 1048.4600430778155, 1075.1398880895254, 1077.3051381858656, 1137.7041969088098, 12186.451609677408, 15878.7618185725, 15884.444044458389, 16196.0, 16198.59503512398, 583677.0, 585649.0, 587932.0, 589702.1029789647, 590177.0, 41794.1641167175, 42149.36775948363, 42216.0, 42311.57688423138, 42418.78790606089, 1351.9459221631025, 1365.706373129782, 1394.3864699532173, 1397.0, 1399.4122468563228, 24683.0, 25730.228093157235, 29438.0, 29515.55726664145, 29994.850025749733, 51615.74192129166, 51616.74191629018, 51737.741311293204, 51798.741006294724, 51802.222966656285, 504838.0, 508514.0, 510756.0, 511493.44253278495, 511962.0, 26440.471190576467, 26610.866945665148, 26862.194134176007, 26877.92488300446, 26902.730972690024, 46565.67171641472, 46816.297755533014, 47250.291245632034, 47272.527274728185, 47833.28250076182, 38214.6178538211, 38970.6102938967, 38976.6102338973, 39278.2144357117, 39351.40972885352, 38804.80597597107, 38831.805840970614, 38868.6113138865, 39777.60222397739, 39987.0, 37290.254194915404, 37925.67260145881, 38402.61597384102, 38496.03759906025, 38767.0, 27418.862905685342, 33823.0, 34559.65440345564, 34801.65198347984, 34900.0, 21637.567248655254, 23691.0, 24590.754092459563, 25315.493690126463, 26289.474210516066], "value": 19576.541038963765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.89104432103886, 361.8643008871673, 371.502187069327, 378.5967944139493, 394.6487626012849, 19202.903985480072, 19413.0, 19742.802571974276, 20584.99999999998, 20643.793562064377, 19243.903780481112, 19282.903585482054, 19326.710099348522, 19514.804851951478, 19633.82197068177, 5006.524380183895, 5648.548116150709, 5888.7055647217685, 5902.527797776189, 5907.822765317026, 5874.6181498202695, 6018.729157187915, 6034.637921724689, 6047.425494578008, 6051.909221361661, 5641.323041235058, 5753.165790960308, 5942.494887934531, 5988.041913293874, 5999.700014999255, 5714.285714285715, 5765.567582431314, 5805.941940580582, 5821.7380217890295, 5841.737121829507, 5061.215511595708, 5071.56891664209, 5077.416097148838, 5356.91964620531, 5418.29562156921, 12530.185537940004, 12534.059945504123, 12682.239065656091, 12723.04577156717, 12724.0, 2251.6509940959177, 2255.875926824024, 2357.634566642173, 2819.309269229052, 2864.8567571621334, 9551.952240238823, 9679.322447428684, 9942.602295908155, 10001.649942251986, 14017.929910350485, 1718.2267979409316, 1767.7260024696193, 1777.5822681669797, 1802.2160360243206, 1829.414587332041, 103193.4840325801, 109891.0, 109895.0, 109947.0, 110004.0, 10607.469626518643, 10758.408287544104, 10879.456027198608, 11115.777684446266, 11197.94401028006, 13515.86484135146, 13618.114822536503, 13633.0, 13651.976101792405, 13684.04211705191, 6491.448226900672, 8301.501909885426, 8317.085120636724, 8368.958155209186, 8369.916300836914, 8152.714654987047, 8278.71024514139, 8299.713544400627, 8395.370347223861, 8460.703875364456, 4198.6221240088535, 4233.1956928183545, 4292.9570704292555, 4349.173657005159, 4410.867673969786, 1745.9786025175415, 1852.1387554787088, 1873.175802646831, 1903.2957805611736, 1913.4451009207173, 811.6753298680575, 861.1861790607941, 904.864395184053, 905.5200743605899, 909.1771946388529, 15420.537383878502, 18475.90762046208, 19823.900880495505, 20066.498337541387, 20257.392278231677, 888.440282621944, 922.7139586728001, 925.9027802080819, 952.2477242977969, 1001.4291853643354, 10079.143272821892, 10314.381137131797, 10361.963803619577, 10388.740281493023, 10411.375317480975, 471742.0, 545229.0, 547594.7747693729, 550002.0, 552483.0, 90679.54660226656, 113796.43101784438, 118076.40961795136, 129025.35487322691, 133162.0, 986.9506524673737, 996.6710985374809, 1044.1177205261542, 1044.7335929337971, 1054.6361505280665, 16108.355665773237, 16487.258073386485, 18000.09999500046, 18069.909650451664, 18448.538786530444, 50256.4923052309, 52151.0, 53653.463465364846, 54268.45731542792, 54283.72858135684, 74324.62837685777, 77409.22590774245, 77470.61264693641, 77477.0, 78532.21467785249, 6623.834404139935, 7444.994925684963, 7793.9220607793195, 7915.366770658448, 8075.676972921252, 11538.82691759641, 11977.484728207173, 12346.320952347707, 12541.0, 12559.748805023666, 9588.616455341707, 10806.621768238074, 10918.23572349928, 10957.671269861918, 11163.330200188015, 10651.57393704243, 10824.242303039027, 10908.672739817817, 11115.777684446428, 11205.0, 11025.338479691245, 11092.946170113826, 11336.263142895685, 11468.197226194086, 11470.942645286721, 5888.528917686489, 6737.124173857367, 7732.265434783687, 7788.260115289038, 8104.797380065545, 9324.533773311172, 10847.294925829796, 10924.890751092706, 10973.615923442641, 11013.568236129251], "value": 9073.631469544893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.2827442827443, 1521.6424140327024, 1715.1595718098135, 1804.7473353730488, 1833.349161047828, 7182.784516464508, 8154.469959452631, 8599.839021732065, 9208.493532855699, 9237.399569028017, 7688.92311076889, 9030.729078127666, 9049.728508144766, 9053.50205738684, 9067.138621830933, 2371.81025517959, 2423.7333893271725, 2424.7938925191293, 2425.648280999254, 2426.9029238830426, 2400.567897778399, 2417.16607770319, 2447.2658202539255, 2450.835852969843, 2456.729759726438, 2426.6602675625427, 2432.20953190213, 2442.096424323003, 2448.3511869354634, 2453.0678342229926, 2394.353524548371, 2395.66460695501, 2416.7704068113503, 2423.0792298926385, 2425.3815277104227, 2375.3586531636533, 2388.689470368841, 2393.258089992108, 2394.437307232799, 2403.579373609611, 9108.59011344491, 9128.634854605807, 9210.171084602418, 9227.769305767342, 9239.49182794946, 5169.767360468751, 5347.759350829222, 5500.642458240201, 5518.0, 5558.055130627763, 3469.4275444551618, 3583.3549961007006, 3796.2597293527774, 3807.676347510437, 3819.026148332185, 925.5511077127587, 1106.9612563560236, 1109.2457129152174, 1112.883147269533, 1116.5980247111033, 12086.576969806103, 12142.45358958849, 12175.147739658227, 12207.816882746765, 12245.0, 4747.454042785055, 4797.688150270221, 4800.927986080212, 4902.48523904992, 4934.432540257844, 10231.897681023243, 10291.691249262534, 10295.794084118426, 10333.22500812442, 10335.534900929477, 5172.741362931838, 5435.912817436529, 5440.265564148868, 5442.8911421771345, 5463.863403414946, 4484.080763443486, 4829.975850120797, 4942.579880710108, 4975.850724478271, 5011.674241174312, 3939.881803545898, 3983.2830090583393, 4045.5752146024834, 4100.118474527991, 4100.7334523255895, 1308.0778051473687, 1308.6205000549924, 1317.1701827848394, 1324.8079028541001, 1335.7395307915058, 814.9877751833727, 867.1761826265074, 884.7036242858586, 931.9860202096974, 935.1524607569966, 5470.699111548824, 5721.628094173949, 5897.734601942923, 6042.244719410074, 6087.969560152171, 424.06282116522215, 429.7979949423766, 431.488685907201, 433.3954133983076, 458.6560079940045, 3914.1054650622814, 3933.704972127102, 4013.3177359848896, 4029.3754468056914, 4076.510818701775, 10699.25105242641, 11031.448427578589, 11085.334879907232, 11105.278156919774, 11127.332360058423, 8435.578221088921, 9300.976892541816, 10698.465076746288, 11031.0, 11223.382713950648, 7038.0, 8386.580670966427, 8436.36727245459, 8506.97916250054, 8508.446950948168, 5040.6471546992825, 5647.265855438766, 5823.563232757476, 5862.062070068769, 5915.645061296336, 10175.84736228972, 10204.540795664065, 10263.025012624088, 10269.537870795682, 10295.7426064346, 10118.6458473956, 10252.128569071712, 10412.947935260578, 10432.374057556572, 10532.0, 6928.618925959121, 7444.590547519939, 7473.88789168152, 7639.274268944441, 7693.884591731016, 8510.957445212734, 8589.613467393858, 8608.139186081342, 8612.18184272493, 8650.43772154808, 7583.696652133853, 7597.810054748676, 7629.046369203849, 7682.154962954182, 7838.294553490213, 7334.523255988343, 7424.888626670496, 7504.137024242282, 7541.132769731551, 7593.620318983918, 6972.372486476242, 7076.681549330189, 7094.255103214088, 7096.680649370894, 7105.6447177639875, 4916.311716359784, 5064.34163558735, 5113.51421614946, 5113.565346945551, 5133.79464821403, 4291.9913820251595, 4978.960038996143, 5107.974460127675, 5162.354705661793, 5234.555062819703], "value": 4565.72666261595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.3909983698461, 298.1681109703926, 309.76148365758365, 313.87131276176774, 315.70323895538195, 5341.999999999995, 5478.369987451444, 5573.7704918032705, 5685.204071429998, 5765.38569200624, 5081.212412076134, 5253.4221235664045, 5387.841614052978, 5628.577856660746, 5672.17753425753, 3953.655757042605, 3971.458266709308, 4334.98718390717, 4336.4362632857765, 4381.18947994622, 4178.749275043492, 4201.256478561409, 4259.70182087254, 4318.892027699301, 4355.802154407547, 4255.872323830275, 4267.167902259061, 4278.35824626307, 4281.764502952336, 4283.67872409569, 3883.689304855619, 3977.6817854571564, 4185.686073544496, 4256.851010214658, 4265.658747300208, 3177.855971850132, 3197.600299962505, 3223.5171820962387, 3277.328562433176, 3500.6149323574386, 5240.764165612519, 5295.655782374133, 5480.492864462305, 5528.760851855005, 5545.445455454423, 4141.0330093205785, 4937.111319962405, 4942.085714142859, 4970.881551650886, 4974.825881094144, 5211.062008838408, 5500.42245564218, 5812.418758124196, 5986.760529578812, 6025.548083893682, 3958.782266975315, 3988.0, 3992.86024989124, 4015.0489390298108, 4037.959620403817, 6288.798920377877, 6304.464120549759, 6384.403899025244, 6398.2641996170105, 6425.068365087036, 3910.9413358799643, 4016.5581786003518, 4038.8990275243355, 4056.3915412688334, 4094.815733292009, 3468.5952189363347, 4167.666346769065, 4254.446921900133, 4270.658347332206, 4271.722338048017, 4981.178105612606, 4989.950100499022, 4993.1262029144755, 5017.8243761468175, 5032.32063671407, 4955.801767929314, 5457.345118585795, 6024.0662697282, 6068.419632416895, 6073.240844894388, 1432.3124900047826, 1466.4500812195427, 1469.2359972814077, 1472.63184203949, 1481.8221813382463, 784.5920121536769, 849.7153453592992, 860.9956950215209, 878.6924576398337, 920.8857282687889, 4102.835886564504, 4122.793860306972, 4345.9348109778375, 4445.0, 4707.5057119002695, 4706.882327941828, 4997.6770093868545, 5209.359051898716, 5223.138182199895, 5234.424213336606, 4099.344104943195, 4356.782160891943, 4539.682222244477, 4550.087943716025, 4600.722642292087, 2962.3630919352013, 3027.2583217111946, 3232.6282477514915, 3239.6436391996863, 3282.6365017187586, 5725.969325521362, 6313.2424109107205, 6320.4311611955145, 6391.904121438182, 6401.0, 5254.448282930237, 6022.397760223943, 6290.816606956414, 6328.493720502441, 6357.586756860789, 5553.777848885999, 5947.583669143119, 6359.777407790612, 6361.201071528512, 6382.840428989312, 4928.186849169847, 4947.45577986414, 6121.173641558511, 6172.722227499863, 6172.783952561639, 5445.727713614383, 5929.6145750526075, 6007.459328660441, 6025.216721826135, 6030.185924900083, 5377.623566350318, 5402.189671549299, 5417.918731218956, 5429.344050064768, 6495.271985765895, 3548.361294966931, 3615.2588719311952, 3738.971433139166, 3985.880423587181, 4059.6549293309217, 6070.848228794315, 6132.877342453036, 6164.116606537852, 6175.752969881334, 6256.812295630956, 5069.340985671839, 5732.226149469769, 5953.434423729739, 5965.8679193423795, 5981.491573216325, 5871.236739224044, 5874.676892770768, 5889.175515427929, 5891.499222565958, 5955.171293635489, 5619.719014049363, 5794.159846822272, 5809.24479817621, 5819.082874970643, 5835.824925252249, 4573.896007836433, 5597.720113994365, 5637.661740295595, 5699.800506982401, 5762.654240745569, 5139.357580302462, 5165.199394093921, 5786.479216870502, 5807.157962095388, 5850.619709718854], "value": 4239.705973361883, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.2258270736774, 708.1077841919181, 766.004194547089, 775.209286527742, 802.7993001749562, 14889.627759306022, 15881.920590397061, 15891.841081589195, 15944.840551594481, 15951.680966380665, 14287.857121428782, 14355.0, 14487.782683259733, 14514.201718905457, 14526.418943242257, 676.5298117808126, 834.253343257784, 852.071242345843, 867.1588559097665, 877.6401675313123, 851.8040850604365, 863.2705363967438, 866.5883705239992, 867.3061550759368, 868.1708967935606, 882.5587206396801, 919.4483310014004, 923.2291036984126, 925.2320573923661, 926.1479438916214, 904.3624244907357, 919.7286800393833, 919.7608621758358, 921.0513171433435, 923.6351641101761, 643.4369926314475, 675.368530424055, 685.3626127701236, 686.584616307132, 686.8557602903396, 12105.455254513568, 12373.69065773354, 12467.625971220878, 12556.121071524996, 14117.929410352883, 11857.762844743143, 14293.928530357385, 14337.28313584327, 14414.351354188982, 14663.34014969329, 11916.582919597773, 11938.22401543897, 11986.940065299617, 12138.939305303416, 12164.878351216463, 3234.5956755405573, 3850.614938506155, 3897.902552436183, 4009.7393669411395, 4020.577839326858, 107448.92551074545, 114108.42945785301, 114229.38710321471, 114544.28183577253, 127017.0, 9861.964493728055, 11220.0, 11342.773144537063, 11364.829527557093, 11380.260283081574, 22795.88602056979, 23464.06143754265, 23492.412689682555, 23504.294871153892, 23532.411689707893, 8058.597070146469, 8061.596920153969, 8130.796730081795, 8307.750767476986, 8403.537805420761, 4496.595306422438, 4516.0, 4568.086382723469, 4585.633149348111, 4659.790309436084, 3583.480395342661, 3713.814309284579, 3713.8885833425043, 3714.758540694846, 3717.6096509866616, 579.273012369482, 579.3511267380477, 593.403629352498, 601.2064075420403, 612.5497759147023, 590.7636945221859, 602.7046747093892, 630.4011189370117, 676.972921083161, 690.8134803602999, 8734.956325218332, 9423.293253005915, 9560.996095409882, 9570.808583828284, 9644.228461723185, 564.6781334639298, 565.3667891960948, 628.8176428835586, 685.7709961543233, 695.7043256615918, 3947.1513624570857, 4295.806688699016, 4638.257878739453, 4724.858254252378, 4771.355866957986, 94104.0, 122930.0, 141336.0, 144252.0, 154902.0, 108981.91018089876, 111237.0, 111399.0, 111786.0, 118347.0, 86003.13996859951, 104354.47822760837, 107080.60512528475, 108543.45728271308, 109712.0, 8194.631241594023, 8659.783505412415, 9145.862812057958, 9937.304388693012, 10054.245931555017, 59962.0, 60947.390526095944, 61765.691171543855, 62368.0, 63526.04710929247, 75072.1174276693, 85255.1474485272, 96788.0, 98771.5061424717, 99481.0, 12585.496580137058, 12673.17624354414, 12966.870331296566, 13006.959443244328, 13035.47858085704, 14570.562883113524, 14605.634859128606, 14743.041702289316, 14826.925865370604, 14834.554963351116, 13398.196108233147, 13617.210902879055, 13621.591352259447, 13707.177569345871, 14312.642183945069, 13648.65878353049, 13691.0, 14092.78860817068, 14145.858541414455, 14399.280035997948, 10885.619003334845, 13439.46242150303, 13494.122882012638, 13626.250556219107, 13762.036657433884, 11157.66527004191, 11228.52776768431, 11233.606823761129, 11316.94341528287, 11448.0, 9978.401295922267, 10495.265331426726, 11324.263922844988, 11346.94326528362, 11566.016888564567], "value": 7754.500395303944, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 117.0, 117.0, 117.0, 102.0, 116.0, 127.0, 161.0, 117.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 111.0, 122.0, 156.0, 125.0, 171.0, 162.0, 142.0, 159.0, 111.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 212.0, 217.0, 232.0, 268.0, 203.0, 201.0, 201.0, 200.0, 193.0], "value": 212.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 84.0, 80.0, 143.0, 59.0, 59.0, 62.0, 64.0, 133.0, 60.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 117.0, 71.0, 70.0, 90.0, 113.0, 69.0, 75.0, 109.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 88.0, 102.0, 130.0, 90.0, 89.0, 92.0, 89.0, 91.0, 90.0], "value": 98.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 152.0, 96.0, 95.0, 98.0, 96.0, 98.0, 151.0, 96.0, 96.0], "value": 107.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 151.0, 141.0, 92.0, 89.0, 90.0, 91.0, 100.0, 93.0, 95.0], "value": 102.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 57.0, 57.0, 58.0, 67.0, 83.0, 87.0, 86.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 103.0, 71.0, 66.0, 78.0, 106.0, 69.0, 99.0, 63.0, 92.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 89.0, 88.0, 113.0, 110.0, 87.0, 86.0, 89.0, 86.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 150.0, 140.0, 138.0, 139.0, 138.0, 141.0, 142.0, 182.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 173.0, 176.0, 171.0, 172.0, 170.0, 169.0, 169.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 67.0, 69.0, 67.0, 71.0, 87.0, 88.0], "value": 72.4, "unit": "score"}]}]} 14:29:00 INFO - Return code: 0 14:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:00 ERROR - # TBPL SUCCESS # 14:29:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:00 INFO - 2016-09-01 14:29:00.374 screenresolution[2024:280366] starting screenresolution argv=screenresolution get 14:29:00 INFO - 2016-09-01 14:29:00.377 screenresolution[2024:280366] Display 0: 1600x1200x32@60 14:29:00 INFO - 2016-09-01 14:29:00.383 screenresolution[2025:280392] starting screenresolution argv=screenresolution list 14:29:00 INFO - Available Modes on Display 0 14:29:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:00 INFO - Intel Iris: 14:29:00 INFO - Chipset Model: Intel Iris 14:29:00 INFO - Type: GPU 14:29:00 INFO - Bus: Built-In 14:29:00 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:00 INFO - Vendor: Intel (0x8086) 14:29:00 INFO - Device ID: 0x0a2e 14:29:00 INFO - Revision ID: 0x0009 14:29:00 INFO - Displays: 14:29:00 INFO - Display: 14:29:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:00 INFO - Display Serial Number: 1600x1200 60 14:29:00 INFO - Main Display: Yes 14:29:00 INFO - Mirror: Off 14:29:00 INFO - Online: Yes 14:29:00 INFO - Rotation: Supported 14:29:00 INFO - Return code: 0 14:29:00 INFO - Running post-action listener: _resource_record_post_action 14:29:00 INFO - [mozharness: 2016-09-01 21:29:00.622725Z] Finished run-tests step (success) 14:29:00 INFO - Running post-run listener: _resource_record_post_run 14:29:00 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 7933440; Write bytes: 707735040; Read time: 74; Write time: 2126 14:29:00 INFO - TinderboxPrint: CPU usage
54.7% 14:29:00 INFO - TinderboxPrint: I/O read bytes / time
7,933,440 / 74 14:29:00 INFO - TinderboxPrint: I/O write bytes / time
707,735,040 / 2,126 14:29:00 INFO - TinderboxPrint: CPU idle
2,191.6 (45.3%) 14:29:00 INFO - TinderboxPrint: CPU system
982.9 (20.3%) 14:29:00 INFO - TinderboxPrint: CPU user
1,663.3 (34.4%) 14:29:00 INFO - TinderboxPrint: Swap in / out
423,419,904 / 0 14:29:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392313344; Write bytes: 387966976; Read time: 29216; Write time: 756 14:29:00 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 7933440; Write bytes: 297727488; Read time: 74; Write time: 1323 14:29:01 INFO - Running post-run listener: _upload_blobber_files 14:29:01 INFO - Blob upload gear active. 14:29:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:01 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 14:29:01 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'] 14:29:01 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 14:29:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:02 INFO - (blobuploader) - INFO - Done attempting. 14:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:04 INFO - (blobuploader) - INFO - Done attempting. 14:29:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:06 INFO - (blobuploader) - INFO - Done attempting. 14:29:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:06 INFO - Return code: 0 14:29:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2adc33e5a9ffeb56b0bcaae3b8d35eabab49f43922ec8c5e57a3cc1edc0839cd507453cd2fa5bbe40c072375f255e079e889cf360bfbdc8bf15ec0f727acb490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69e1945cd9fbc702d48520b509bf81fe1d0e054863eac828edfdc60818bfb3dd062946226abf3ab509d212aed70f3bbd5041c71c1b0b8bf6040127e7f33082fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff395131fcf04a894c9337d635b5a729161f95f79640bad3ac72c410f83eb1fa2bbbb60d2b00e61a6595665119b24a2c06ede427e89e1748e76583312fb663f"} 14:29:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:06 INFO - Contents: 14:29:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2adc33e5a9ffeb56b0bcaae3b8d35eabab49f43922ec8c5e57a3cc1edc0839cd507453cd2fa5bbe40c072375f255e079e889cf360bfbdc8bf15ec0f727acb490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69e1945cd9fbc702d48520b509bf81fe1d0e054863eac828edfdc60818bfb3dd062946226abf3ab509d212aed70f3bbd5041c71c1b0b8bf6040127e7f33082fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff395131fcf04a894c9337d635b5a729161f95f79640bad3ac72c410f83eb1fa2bbbb60d2b00e61a6595665119b24a2c06ede427e89e1748e76583312fb663f"} 14:29:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:06 INFO - Copying logs to upload dir... 14:29:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.253405 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-01 14:29:06.612517) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 14:29:06.616166) ========= 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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/2adc33e5a9ffeb56b0bcaae3b8d35eabab49f43922ec8c5e57a3cc1edc0839cd507453cd2fa5bbe40c072375f255e079e889cf360bfbdc8bf15ec0f727acb490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69e1945cd9fbc702d48520b509bf81fe1d0e054863eac828edfdc60818bfb3dd062946226abf3ab509d212aed70f3bbd5041c71c1b0b8bf6040127e7f33082fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff395131fcf04a894c9337d635b5a729161f95f79640bad3ac72c410f83eb1fa2bbbb60d2b00e61a6595665119b24a2c06ede427e89e1748e76583312fb663f"} build_url:https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/Or1O4hiXRZajtxWSuAdSQQ/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/2adc33e5a9ffeb56b0bcaae3b8d35eabab49f43922ec8c5e57a3cc1edc0839cd507453cd2fa5bbe40c072375f255e079e889cf360bfbdc8bf15ec0f727acb490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/69e1945cd9fbc702d48520b509bf81fe1d0e054863eac828edfdc60818bfb3dd062946226abf3ab509d212aed70f3bbd5041c71c1b0b8bf6040127e7f33082fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ff395131fcf04a894c9337d635b5a729161f95f79640bad3ac72c410f83eb1fa2bbbb60d2b00e61a6595665119b24a2c06ede427e89e1748e76583312fb663f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 14:29:06.651074) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:29:06.651424) ========= 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.EXQbfdYMGl/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.Bs4KX0xWh5/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005105 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 14:29:06.701946) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 14:29:06.702448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 14:29:06.702980) ========= ========= Total master_lag: 0.22 =========