builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0070 starttime: 1472230826.26 results: success (0) buildid: 20160826072316 builduid: c224707d993a415b8eeead9f8c79965a revision: 69fcb7b0e100aeb41df63129d02222d16ae3fef9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.276268) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.276861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.277160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.306424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.306729) ========= 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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-26 10:00:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-08-26 10:00:26 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.469337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.469728) ========= 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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.027480 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.518879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:26.519276) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 69fcb7b0e100aeb41df63129d02222d16ae3fef9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 69fcb7b0e100aeb41df63129d02222d16ae3fef9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-26 10:00:26,596 truncating revision to first 12 chars 2016-08-26 10:00:26,596 Setting DEBUG logging. 2016-08-26 10:00:26,596 attempt 1/10 2016-08-26 10:00:26,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/69fcb7b0e100?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 10:00:27,264 unpacking tar archive at: autoland-69fcb7b0e100/testing/mozharness/ program finished with exit code 0 elapsedTime=0.918389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:27.460096) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:27.460475) ========= script_repo_revision: 69fcb7b0e100aeb41df63129d02222d16ae3fef9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:27.460911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:27.461184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 10:00:27.479883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-26 10:00:27.480312) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:00:27 INFO - MultiFileLogger online at 20160826 10:00:27 in /builds/slave/test 10:00:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:00:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:27 INFO - {'append_to_log': False, 10:00:27 INFO - 'base_work_dir': '/builds/slave/test', 10:00:27 INFO - 'blob_upload_branch': 'Autoland', 10:00:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:27 INFO - 'branch': 'Autoland', 10:00:27 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:27 INFO - 'config_files': ('talos/mac_config.py',), 10:00:27 INFO - 'default_actions': ('clobber', 10:00:27 INFO - 'read-buildbot-config', 10:00:27 INFO - 'download-and-extract', 10:00:27 INFO - 'populate-webroot', 10:00:27 INFO - 'create-virtualenv', 10:00:27 INFO - 'install', 10:00:27 INFO - 'run-tests'), 10:00:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:27 INFO - 'download_minidump_stackwalk': True, 10:00:27 INFO - 'download_symbols': 'ondemand', 10:00:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:27 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:27 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:27 INFO - 'installer_path': 'installer.exe', 10:00:27 INFO - 'log_level': 'info', 10:00:27 INFO - 'log_name': 'talos', 10:00:27 INFO - 'log_to_console': True, 10:00:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:00:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:00:27 INFO - 'opt_config_files': (), 10:00:27 INFO - 'pip_index': False, 10:00:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:00:27 INFO - 'cmd': ('bash', 10:00:27 INFO - '-c', 10:00:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:00:27 INFO - 'enabled': True, 10:00:27 INFO - 'halt_on_failure': False, 10:00:27 INFO - 'name': 'check_screen_resolution'},), 10:00:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:00:27 INFO - 'cmd': ('bash', 10:00:27 INFO - '-c', 10:00:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:00:27 INFO - 'enabled': True, 10:00:27 INFO - 'halt_on_failure': False, 10:00:27 INFO - 'name': 'check_screen_resolution'},), 10:00:27 INFO - 'run_cmd_checks_enabled': True, 10:00:27 INFO - 'sps_profile': False, 10:00:27 INFO - 'sps_profile_interval': 0, 10:00:27 INFO - 'suite': 'dromaeojs-e10s', 10:00:27 INFO - 'system_bits': '32', 10:00:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:27 INFO - 'title': 't-yosemite-r7-0070', 10:00:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:27 INFO - 'use_talos_json': True, 10:00:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:27 INFO - 'work_dir': 'build'} 10:00:27 INFO - [mozharness: 2016-08-26 17:00:27.680527Z] Running clobber step. 10:00:27 INFO - Running pre-action listener: _resource_record_pre_action 10:00:27 INFO - Running main action method: clobber 10:00:27 INFO - rmtree: /builds/slave/test/build 10:00:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:29 INFO - Running post-action listener: _resource_record_post_action 10:00:29 INFO - [mozharness: 2016-08-26 17:00:29.986094Z] Finished clobber step (success) 10:00:29 INFO - [mozharness: 2016-08-26 17:00:29.986243Z] Running read-buildbot-config step. 10:00:29 INFO - Running pre-action listener: _resource_record_pre_action 10:00:29 INFO - Running main action method: read_buildbot_config 10:00:29 INFO - Using buildbot properties: 10:00:29 INFO - { 10:00:29 INFO - "project": "", 10:00:29 INFO - "product": "firefox", 10:00:29 INFO - "script_repo_revision": "production", 10:00:29 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 10:00:29 INFO - "repository": "", 10:00:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 10:00:29 INFO - "buildid": "20160826072316", 10:00:29 INFO - "pgo_build": "False", 10:00:29 INFO - "basedir": "/builds/slave/test", 10:00:29 INFO - "buildnumber": 149, 10:00:29 INFO - "slavename": "t-yosemite-r7-0070", 10:00:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:00:29 INFO - "platform": "yosemite_r7", 10:00:29 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 10:00:29 INFO - "branch": "autoland", 10:00:29 INFO - "repo_path": "integration/autoland", 10:00:29 INFO - "revision": "69fcb7b0e100aeb41df63129d02222d16ae3fef9", 10:00:29 INFO - "stage_platform": "macosx64", 10:00:29 INFO - "builduid": "c224707d993a415b8eeead9f8c79965a", 10:00:29 INFO - "slavebuilddir": "test" 10:00:29 INFO - } 10:00:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 10:00:29 INFO - Running post-action listener: _resource_record_post_action 10:00:29 INFO - [mozharness: 2016-08-26 17:00:29.989622Z] Finished read-buildbot-config step (success) 10:00:29 INFO - [mozharness: 2016-08-26 17:00:29.989736Z] Running download-and-extract step. 10:00:29 INFO - Running pre-action listener: _resource_record_pre_action 10:00:29 INFO - Running main action method: download_and_extract 10:00:29 INFO - mkdir: /builds/slave/test/build/tests 10:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:29 INFO - trying https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 10:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 10:00:31 INFO - Downloaded 1199 bytes. 10:00:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 10:00:31 INFO - Using the following test package requirements: 10:00:31 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:00:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 10:00:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 10:00:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'jsshell-mac.zip'], 10:00:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 10:00:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 10:00:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 10:00:31 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 10:00:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 10:00:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 10:00:31 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 10:00:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:00: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')]} 10:00:31 INFO - trying https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:00:31 INFO - Downloading https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:00:32 INFO - Downloaded 16368913 bytes. 10:00:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:00:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:00: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')]} 10:00:39 INFO - trying https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:00:39 INFO - Downloading https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 10:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:00:40 INFO - Downloaded 16368913 bytes. 10:00:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 10:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:47 INFO - trying https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:00:47 INFO - Downloading https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 10:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:00:48 INFO - Downloaded 14413998 bytes. 10:00:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 10:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:48 INFO - trying https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:00:48 INFO - Downloading https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 10:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 10:00:51 INFO - Downloaded 111614250 bytes. 10:00:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:00:51 INFO - mkdir: /builds/slave/test/properties 10:00:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:51 INFO - Contents: 10:00:51 INFO - build_url:https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 10:00:52 INFO - Running post-action listener: _resource_record_post_action 10:00:52 INFO - Running post-action listener: set_extra_try_arguments 10:00:52 INFO - [mozharness: 2016-08-26 17:00:52.174475Z] Finished download-and-extract step (success) 10:00:52 INFO - [mozharness: 2016-08-26 17:00:52.174615Z] Running populate-webroot step. 10:00:52 INFO - Running pre-action listener: _resource_record_pre_action 10:00:52 INFO - Running main action method: populate_webroot 10:00:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:52 INFO - '--tppagecycles', 10:00:52 INFO - '7'], 10:00:52 INFO - 'tests': ['tsvgm']}}, 10:00:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['damp', 'tps']}, 10:00:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['damp', 'tps']}, 10:00:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['dromaeo_dom']}, 10:00:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['basic_compositor_video']}, 10:00:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['a11yr', 10:00:52 INFO - 'ts_paint', 10:00:52 INFO - 'tpaint', 10:00:52 INFO - 'sessionrestore', 10:00:52 INFO - 'sessionrestore_no_auto_restore', 10:00:52 INFO - 'tabpaint']}, 10:00:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tsvgx', 10:00:52 INFO - 'tsvgr_opacity', 10:00:52 INFO - 'tart', 10:00:52 INFO - 'tscrollx', 10:00:52 INFO - 'cart']}, 10:00:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:52 INFO - 'tsvgr_opacity', 10:00:52 INFO - 'tart', 10:00:52 INFO - 'tscrollx', 10:00:52 INFO - 'cart']}, 10:00:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s'], 10:00:52 INFO - 'tests': ['tp5o']}, 10:00:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'tests': ['tp5o']}, 10:00:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--disable-e10s', 10:00:52 INFO - '--xperf_path', 10:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:52 INFO - 'tests': ['tp5n']}, 10:00:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:52 INFO - 'talos_options': ['--xperf_path', 10:00:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:52 INFO - 'tests': ['tp5n']}}, 10:00:52 INFO - 'talos.zip': {'path': '', 10:00:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:52 INFO - Running post-action listener: _resource_record_post_action 10:00:52 INFO - [mozharness: 2016-08-26 17:00:52.193790Z] Finished populate-webroot step (success) 10:00:52 INFO - [mozharness: 2016-08-26 17:00:52.193898Z] Running create-virtualenv step. 10:00:52 INFO - Running pre-action listener: _resource_record_pre_action 10:00:52 INFO - Running main action method: create_virtualenv 10:00:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:00:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:52 INFO - Using real prefix '/tools/python27' 10:00:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:55 INFO - Installing pip.................done. 10:00:55 INFO - Return code: 0 10:00:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:55 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:00:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:00:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:55 INFO - 'HOME': '/Users/cltbld', 10:00:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:55 INFO - 'LOGNAME': 'cltbld', 10:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:55 INFO - 'MOZ_NO_REMOTE': '1', 10:00:55 INFO - 'NO_EM_RESTART': '1', 10:00:55 INFO - 'PAGER': '/bin/cat', 10:00:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:55 INFO - 'PWD': '/builds/slave/test', 10:00:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:55 INFO - 'SHELL': '/bin/bash', 10:00:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:00:55 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:00:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:55 INFO - 'USER': 'cltbld', 10:00:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:55 INFO - 'XPC_FLAGS': '0x0', 10:00:55 INFO - 'XPC_SERVICE_NAME': '0', 10:00:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:00:56 INFO - Cleaning up... 10:00:56 INFO - Return code: 0 10:00:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:56 INFO - 'HOME': '/Users/cltbld', 10:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:56 INFO - 'LOGNAME': 'cltbld', 10:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:56 INFO - 'MOZ_NO_REMOTE': '1', 10:00:56 INFO - 'NO_EM_RESTART': '1', 10:00:56 INFO - 'PAGER': '/bin/cat', 10:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:56 INFO - 'PWD': '/builds/slave/test', 10:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:56 INFO - 'SHELL': '/bin/bash', 10:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:00:56 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:56 INFO - 'USER': 'cltbld', 10:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:56 INFO - 'XPC_FLAGS': '0x0', 10:00:56 INFO - 'XPC_SERVICE_NAME': '0', 10:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:56 INFO - Downloading/unpacking psutil>=3.1.1 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:59 INFO - Installing collected packages: psutil 10:00:59 INFO - Running setup.py install for psutil 10:00:59 INFO - building 'psutil._psutil_osx' extension 10:00:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:01:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:01:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:01:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:01:00 INFO - building 'psutil._psutil_posix' extension 10:01:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:01:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:01:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:01:00 INFO - ^ 10:01:00 INFO - 1 warning generated. 10:01:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:00 INFO - Successfully installed psutil 10:01:00 INFO - Cleaning up... 10:01:01 INFO - Return code: 0 10:01:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:01 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:01 INFO - 'HOME': '/Users/cltbld', 10:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:01 INFO - 'LOGNAME': 'cltbld', 10:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:01 INFO - 'MOZ_NO_REMOTE': '1', 10:01:01 INFO - 'NO_EM_RESTART': '1', 10:01:01 INFO - 'PAGER': '/bin/cat', 10:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:01 INFO - 'PWD': '/builds/slave/test', 10:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:01 INFO - 'SHELL': '/bin/bash', 10:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:01 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:01 INFO - 'USER': 'cltbld', 10:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:01 INFO - 'XPC_FLAGS': '0x0', 10:01:01 INFO - 'XPC_SERVICE_NAME': '0', 10:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:03 INFO - Installing collected packages: mozsystemmonitor 10:01:03 INFO - Running setup.py install for mozsystemmonitor 10:01:03 INFO - Successfully installed mozsystemmonitor 10:01:03 INFO - Cleaning up... 10:01:04 INFO - Return code: 0 10:01:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:04 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:04 INFO - 'HOME': '/Users/cltbld', 10:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:04 INFO - 'LOGNAME': 'cltbld', 10:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:04 INFO - 'MOZ_NO_REMOTE': '1', 10:01:04 INFO - 'NO_EM_RESTART': '1', 10:01:04 INFO - 'PAGER': '/bin/cat', 10:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:04 INFO - 'PWD': '/builds/slave/test', 10:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:04 INFO - 'SHELL': '/bin/bash', 10:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:04 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:04 INFO - 'USER': 'cltbld', 10:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:04 INFO - 'XPC_FLAGS': '0x0', 10:01:04 INFO - 'XPC_SERVICE_NAME': '0', 10:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:04 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:07 INFO - warning: no files found matching '*.txt' 10:01:07 INFO - no previously-included directories found matching 'build' 10:01:07 INFO - no previously-included directories found matching 'dist' 10:01:07 INFO - no previously-included directories found matching '.git*' 10:01:07 INFO - Installing collected packages: jsonschema, functools32 10:01:07 INFO - Running setup.py install for functools32 10:01:07 INFO - warning: no files found matching '*.txt' 10:01:07 INFO - no previously-included directories found matching 'build' 10:01:07 INFO - no previously-included directories found matching 'dist' 10:01:07 INFO - no previously-included directories found matching '.git*' 10:01:07 INFO - Successfully installed jsonschema functools32 10:01:07 INFO - Cleaning up... 10:01:07 INFO - Return code: 0 10:01:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:07 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:07 INFO - 'HOME': '/Users/cltbld', 10:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:07 INFO - 'LOGNAME': 'cltbld', 10:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:07 INFO - 'MOZ_NO_REMOTE': '1', 10:01:07 INFO - 'NO_EM_RESTART': '1', 10:01:07 INFO - 'PAGER': '/bin/cat', 10:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:07 INFO - 'PWD': '/builds/slave/test', 10:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:07 INFO - 'SHELL': '/bin/bash', 10:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:07 INFO - 'USER': 'cltbld', 10:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:07 INFO - 'XPC_FLAGS': '0x0', 10:01:07 INFO - 'XPC_SERVICE_NAME': '0', 10:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:01:07 INFO - Cleaning up... 10:01:07 INFO - Return code: 0 10:01:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:07 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:07 INFO - 'HOME': '/Users/cltbld', 10:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:07 INFO - 'LOGNAME': 'cltbld', 10:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:07 INFO - 'MOZ_NO_REMOTE': '1', 10:01:07 INFO - 'NO_EM_RESTART': '1', 10:01:07 INFO - 'PAGER': '/bin/cat', 10:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:07 INFO - 'PWD': '/builds/slave/test', 10:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:07 INFO - 'SHELL': '/bin/bash', 10:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:07 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:07 INFO - 'USER': 'cltbld', 10:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:07 INFO - 'XPC_FLAGS': '0x0', 10:01:07 INFO - 'XPC_SERVICE_NAME': '0', 10:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:11 INFO - Downloading docopt-0.6.1.tar.gz 10:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:11 INFO - Running setup.py install for blobuploader 10:01:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:01:11 INFO - Running setup.py install for requests 10:01:12 INFO - Running setup.py install for docopt 10:01:12 INFO - Successfully installed blobuploader requests docopt 10:01:12 INFO - Cleaning up... 10:01:12 INFO - Return code: 0 10:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:13 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:13 INFO - 'HOME': '/Users/cltbld', 10:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:13 INFO - 'LOGNAME': 'cltbld', 10:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:13 INFO - 'MOZ_NO_REMOTE': '1', 10:01:13 INFO - 'NO_EM_RESTART': '1', 10:01:13 INFO - 'PAGER': '/bin/cat', 10:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:13 INFO - 'PWD': '/builds/slave/test', 10:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:13 INFO - 'SHELL': '/bin/bash', 10:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:13 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:13 INFO - 'USER': 'cltbld', 10:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:13 INFO - 'XPC_FLAGS': '0x0', 10:01:13 INFO - 'XPC_SERVICE_NAME': '0', 10:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-yAHXHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-A_uZj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3ENZ_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-3HRkxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-oQ3Xbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-HIby8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:13 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-lzaNrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-A223l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-Xx4TS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-rp6XtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-6K0Qvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-9mzDEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-gSpZuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-R_dXaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-RqqacP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:14 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-8fyMBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:15 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-JpbQcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:15 INFO - Running setup.py install for manifestparser 10:01:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Running setup.py install for mozcrash 10:01:15 INFO - Running setup.py install for mozdebug 10:01:15 INFO - Running setup.py install for mozdevice 10:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:01:15 INFO - Running setup.py install for mozfile 10:01:15 INFO - Running setup.py install for mozhttpd 10:01:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Running setup.py install for mozinfo 10:01:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Running setup.py install for mozInstall 10:01:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Running setup.py install for mozleak 10:01:16 INFO - Running setup.py install for mozlog 10:01:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Running setup.py install for moznetwork 10:01:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:01:16 INFO - Running setup.py install for mozprocess 10:01:16 INFO - Running setup.py install for mozprofile 10:01:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:01:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:01:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:01:17 INFO - Running setup.py install for mozrunner 10:01:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:01:17 INFO - Running setup.py install for mozscreenshot 10:01:17 INFO - Running setup.py install for moztest 10:01:17 INFO - Running setup.py install for mozversion 10:01:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:01:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:17 INFO - Cleaning up... 10:01:17 INFO - Return code: 0 10:01:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:17 INFO - 'HOME': '/Users/cltbld', 10:01:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:17 INFO - 'LOGNAME': 'cltbld', 10:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:17 INFO - 'MOZ_NO_REMOTE': '1', 10:01:17 INFO - 'NO_EM_RESTART': '1', 10:01:17 INFO - 'PAGER': '/bin/cat', 10:01:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:17 INFO - 'PWD': '/builds/slave/test', 10:01:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:17 INFO - 'SHELL': '/bin/bash', 10:01:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:17 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:17 INFO - 'USER': 'cltbld', 10:01:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:17 INFO - 'XPC_FLAGS': '0x0', 10:01:17 INFO - 'XPC_SERVICE_NAME': '0', 10:01:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-bM3TrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-78cA_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-X7a9vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-UWhe53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-oMsfD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-PIEasC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-851Ui8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-MIrj9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-LgJN_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:01:18 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-g0tOcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-zCyjQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-OoD_IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-4g2gEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-RQWPlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-sm6d1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-xWXPRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:01:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:01:19 INFO - Running setup.py (path:/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/pip-XtGSdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:22 INFO - Downloading blessings-1.6.tar.gz 10:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:22 INFO - Installing collected packages: blessings 10:01:22 INFO - Running setup.py install for blessings 10:01:22 INFO - Successfully installed blessings 10:01:22 INFO - Cleaning up... 10:01:22 INFO - Return code: 0 10:01:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:01:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:23 INFO - Reading from file tmpfile_stdout 10:01:23 INFO - Current package versions: 10:01:23 INFO - blessings == 1.6 10:01:23 INFO - blobuploader == 1.2.4 10:01:23 INFO - docopt == 0.6.1 10:01:23 INFO - functools32 == 3.2.3-2 10:01:23 INFO - jsonschema == 2.5.1 10:01:23 INFO - manifestparser == 1.1 10:01:23 INFO - mozInstall == 1.12 10:01:23 INFO - mozcrash == 0.17 10:01:23 INFO - mozdebug == 0.1 10:01:23 INFO - mozdevice == 0.48 10:01:23 INFO - mozfile == 1.2 10:01:23 INFO - mozhttpd == 0.7 10:01:23 INFO - mozinfo == 0.9 10:01:23 INFO - mozleak == 0.1 10:01:23 INFO - mozlog == 3.3 10:01:23 INFO - moznetwork == 0.27 10:01:23 INFO - mozprocess == 0.23 10:01:23 INFO - mozprofile == 0.28 10:01:23 INFO - mozrunner == 6.12 10:01:23 INFO - mozscreenshot == 0.1 10:01:23 INFO - mozsystemmonitor == 0.3 10:01:23 INFO - moztest == 0.7 10:01:23 INFO - mozversion == 1.4 10:01:23 INFO - psutil == 3.1.1 10:01:23 INFO - requests == 1.2.3 10:01:23 INFO - wsgiref == 0.1.2 10:01:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:23 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 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:23 INFO - 'HOME': '/Users/cltbld', 10:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:23 INFO - 'LOGNAME': 'cltbld', 10:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:23 INFO - 'MOZ_NO_REMOTE': '1', 10:01:23 INFO - 'NO_EM_RESTART': '1', 10:01:23 INFO - 'PAGER': '/bin/cat', 10:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:23 INFO - 'PWD': '/builds/slave/test', 10:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:23 INFO - 'SHELL': '/bin/bash', 10:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:23 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:23 INFO - 'USER': 'cltbld', 10:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:23 INFO - 'XPC_FLAGS': '0x0', 10:01:23 INFO - 'XPC_SERVICE_NAME': '0', 10:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:01:23 INFO - Cleaning up... 10:01:23 INFO - Return code: 0 10:01:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:01: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')]} 10:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d694a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d729618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd668ccb0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, '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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:01: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', 'jsonschema'] in /builds/slave/test/build 10:01: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 jsonschema 10:01:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:23 INFO - 'HOME': '/Users/cltbld', 10:01:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:23 INFO - 'LOGNAME': 'cltbld', 10:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:23 INFO - 'MOZ_NO_REMOTE': '1', 10:01:23 INFO - 'NO_EM_RESTART': '1', 10:01:23 INFO - 'PAGER': '/bin/cat', 10:01:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:23 INFO - 'PWD': '/builds/slave/test', 10:01:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:23 INFO - 'SHELL': '/bin/bash', 10:01:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:23 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:23 INFO - 'USER': 'cltbld', 10:01:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:23 INFO - 'XPC_FLAGS': '0x0', 10:01:23 INFO - 'XPC_SERVICE_NAME': '0', 10:01:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:01:23 INFO - Cleaning up... 10:01:23 INFO - Return code: 0 10:01:23 INFO - Running post-action listener: _resource_record_post_action 10:01:23 INFO - Running post-action listener: _start_resource_monitoring 10:01:23 INFO - Starting resource monitoring. 10:01:23 INFO - [mozharness: 2016-08-26 17:01:23.780760Z] Finished create-virtualenv step (success) 10:01:23 INFO - [mozharness: 2016-08-26 17:01:23.781731Z] Running install step. 10:01:23 INFO - Running pre-action listener: _resource_record_pre_action 10:01:23 INFO - Running main action method: install 10:01:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:01:24 INFO - Reading from file tmpfile_stdout 10:01:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:01:24 INFO - Reading from file tmpfile_stdout 10:01:24 INFO - Output received: 10:01:24 INFO - Usage: mozinstall [options] installer 10:01:24 INFO - Options: 10:01:24 INFO - -h, --help show this help message and exit 10:01:24 INFO - -d DEST, --destination=DEST 10:01:24 INFO - Directory to install application into. [default: 10:01:24 INFO - "/builds/slave/test"] 10:01:24 INFO - --app=APP Application being installed. [default: firefox] 10:01:24 INFO - mkdir: /builds/slave/test/build/application 10:01:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:01:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:01:59 INFO - Reading from file tmpfile_stdout 10:01:59 INFO - Output received: 10:01:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:01:59 INFO - Running post-action listener: _resource_record_post_action 10:01:59 INFO - [mozharness: 2016-08-26 17:01:59.234451Z] Finished install step (success) 10:01:59 INFO - [mozharness: 2016-08-26 17:01:59.234598Z] Running run-tests step. 10:01:59 INFO - Running pre-action listener: _resource_record_pre_action 10:01:59 INFO - Running main action method: run_tests 10:01:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:01:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:01:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:01:59 INFO - 2016-08-26 10:01:59.249 screenresolution[1635:7499] starting screenresolution argv=screenresolution get 10:01:59 INFO - 2016-08-26 10:01:59.251 screenresolution[1635:7499] Display 0: 1600x1200x32@60 10:01:59 INFO - 2016-08-26 10:01:59.257 screenresolution[1636:7502] starting screenresolution argv=screenresolution list 10:01:59 INFO - Available Modes on Display 0 10:01:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:01:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:01:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:01:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:01:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:01:59 INFO - Intel Iris: 10:01:59 INFO - Chipset Model: Intel Iris 10:01:59 INFO - Type: GPU 10:01:59 INFO - Bus: Built-In 10:01:59 INFO - VRAM (Dynamic, Max): 1536 MB 10:01:59 INFO - Vendor: Intel (0x8086) 10:01:59 INFO - Device ID: 0x0a2e 10:01:59 INFO - Revision ID: 0x0009 10:01:59 INFO - Displays: 10:01:59 INFO - Display: 10:01:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:01:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:01:59 INFO - Display Serial Number: 1600x1200 60 10:01:59 INFO - Main Display: Yes 10:01:59 INFO - Mirror: Off 10:01:59 INFO - Online: Yes 10:01:59 INFO - Rotation: Supported 10:01:59 INFO - Return code: 0 10:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:59 INFO - Python 2.7.3 10:01:59 INFO - Return code: 0 10:01:59 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:59 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 0x10d5f8d30>, '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 0x10d35ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5f0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:01:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:01:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:01:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:59 INFO - Return code: 0 10:01:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:01:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:01:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:01:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tyOMWJOJNw/Render', 10:01:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:59 INFO - 'HOME': '/Users/cltbld', 10:01:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:59 INFO - 'LOGNAME': 'cltbld', 10:01:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:59 INFO - 'MOZ_NO_REMOTE': '1', 10:01:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:59 INFO - 'NO_EM_RESTART': '1', 10:01:59 INFO - 'PAGER': '/bin/cat', 10:01:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:59 INFO - 'PWD': '/builds/slave/test', 10:01:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:59 INFO - 'SHELL': '/bin/bash', 10:01:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G2ifIAEXuU/Listeners', 10:01:59 INFO - 'TMPDIR': '/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/', 10:01:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:59 INFO - 'USER': 'cltbld', 10:01:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:59 INFO - 'XPC_FLAGS': '0x0', 10:01:59 INFO - 'XPC_SERVICE_NAME': '0', 10:01:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:01:59 INFO - mozversion application_buildid: 20160826072316 10:01:59 INFO - mozversion application_changeset: 69fcb7b0e100aeb41df63129d02222d16ae3fef9 10:01:59 INFO - mozversion application_display_name: Nightly 10:01:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:59 INFO - mozversion application_name: Firefox 10:01:59 INFO - mozversion application_remotingname: firefox 10:01:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:01:59 INFO - mozversion application_vendor: Mozilla 10:01:59 INFO - mozversion application_version: 51.0a1 10:01:59 INFO - mozversion platform_buildid: 20160826072316 10:01:59 INFO - mozversion platform_changeset: 69fcb7b0e100aeb41df63129d02222d16ae3fef9 10:01:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:01:59 INFO - mozversion platform_version: 51.0a1 10:01:59 INFO - using testdate: 1472230919 10:01:59 INFO - actual date: 1472230919 10:01:59 INFO - starting webserver on 'localhost:49271' 10:01:59 INFO - SUITE-START | Running 2 tests 10:01:59 INFO - TEST-START | dromaeo_css 10:01:59 INFO - operating with platform_type : mac_ 10:01:59 INFO - Initialising browser for dromaeo_css test... 10:01:59 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpRBWj6c/profile http://localhost:49271/getInfo.html) 10:02:02 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:02:02 INFO - PROCESS | 1646 | colorDepth:24 10:02:02 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:02:02 INFO - PROCESS | 1646 | __metrics 10:02:02 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 10:02:03 INFO - TEST-INFO | 1646: exit 0 10:02:03 INFO - Browser initialized. 10:02:03 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:03 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmpRBWj6c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:15 INFO - PROCESS | 1649 | RSS: Main: 243900416 10:02:15 INFO - PROCESS | 1649 | 10:03:05 INFO - PROCESS | 1649 | 1472230985038 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:05:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 10:05:18 INFO - PROCESS | 1649 | RSS: Main: 266817536 10:05:18 INFO - PROCESS | 1649 | 10:08:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 10:08:21 INFO - PROCESS | 1649 | RSS: Main: 276471808 10:08:21 INFO - PROCESS | 1649 | 10:11:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 10:11:24 INFO - PROCESS | 1649 | RSS: Main: 276021248 10:11:24 INFO - PROCESS | 1649 | 10:14:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 10:14:26 INFO - PROCESS | 1649 | RSS: Main: 272076800 10:14:26 INFO - PROCESS | 1649 | 10:17:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 10:17:30 INFO - PROCESS | 1649 | RSS: Main: 277233664 10:17:30 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 10:20:33 INFO - PROCESS | 1649 | RSS: Main: 280215552 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | __start_tp_report 10:20:33 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 10:20:33 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 10:20:33 INFO - PROCESS | 1649 | |i|pagename|runs| 10:20:33 INFO - PROCESS | 1649 | |0;dojo.html;3399.7790143640646;3419.9316013679727;3427.8114703691294;3446.758726889118;3460.359833430814;5545.805896793613;5636.66180029198;5731.197632331472;5790.33411157717;5792.015357389243;5449.155380915954;5502.339719233688;5711.828645140642;5735.741891614877;5740.913886291709;5151.71665558395;5268.710220937847;5295.443978382272;5340.279062326575;5341.278927344817;5106.897862042757;5186.222066689989;5285.075111855429;5301.920471192935;5380.91928621071;4280.357946308063;5275.446078161776;5279.762410691528;5283.049051170788;5296;4535.705179163377;5265;5285.154375299972;5293.947060529384;5294.549963253128;4559.817607295704;5162.664426812245;5239.13554263546;5246.160614301693;5271.736413179326;5658.603897727161;5664.716764161775;5666.971665141689;5669.433056694339;5716.685582292972;5080.466551012164;6155.261368635747;6183.443490085869;6238.814625221194;6261.092141639482;6153.630782153085;6155.169052177944;6246.812595622138;6261.624302541862;6262.311145774007;4714.4106986626675;5789.3921138279875;5826.329972053183;5874.588778785486;5941.643501389931;4595.724256544551;6256.061590761331;6342.936570634327;6362.522810789209;6378.266499352541;4974.925376119361;5414.7021913795115;6027.758889644453;6132.448079672851;6132.724027418777;5157.896842063213;5417.51242388187;5887.087501437284;6269.717862696099;6272.717727702265;6106.633601983806;6234.9688251558455;6245.96877015612;6255.874882502325;6271.3415091414745;6096.435975519003;6099.309783606499;6116.1836049259855;6136.519078024374;6262.12330273762;4166.395872598457;4956.752162391866;4969.130402179604;4994.725290109006;5008.098542262428;4407.030453300269;4449.57729015743;4463.776811159429;4481.395011673448;4483.775811209492;5634.97182514093;5855.063189889683;5866.325372582122;5892.970535147297;5901.439363260483;6197.81406557804;6228.34602366754;6238.1266622672865;6259.405356491126;6261.968690156611;5906.5570082244;5929.140274660236;5929.466348028612;5935.851603709942;5976.133460648181;5339.332583427072;5418.2685337479725;5459.727013649381;5463.508284254436;5475.780968761284;5346.358436987586;6269.122322874801;6387.233531976192;6432.292447830829;6443;6213.720382582705;6226.782062627967;6258.9374106260175;6259.624422534663;6273.404026617464;6282.623042617458;6314;6337.936620633919;6339.841503962438;6455.838604034937;6190.81427557174;6191.288001879661;6192.535559832941;6192.535559832941;6235.033569796688;5019.949800501949;5202.97398513005;6219.626822390671;6256.562040657111;6282.120503129657;5811.4479124483105;6096.664683442454;6124.8775024500155;6125.601835880653;6150.169727086786;5104.310918026167;6119;6146.416090471398;6147.493864003348;6163.291221509584;5860.238169037998;5901.439363260483;5975.492083172805;5996.820095397145;6055.576109672281;5848.941510584839;5886.470217680429;5929.673867937132;5933.881322373615;6175.722092505938;5776.971115144397;5781.855453613525;5803.680797556175;5806.361300256884;5837.708114594338 10:20:33 INFO - PROCESS | 1649 | |1;ext.html;490.044413393882;500.958007344723;531.3358302122347;543.3045701502078;559.3958524793222;38345.42481862774;40569.59430405695;40736.59263407365;40893;40917.59082409175;41628.791856040676;41939.37090943631;42202.36696449556;42208;42480.57519424812;9592.760180995461;9793.951030244874;9813.313068085237;9831.410115393064;9854.113129818315;9611.80776384472;9707.271954603397;9731.270154738388;9746.805063898717;9759.853602195937;9720.222382209442;9750.317477776558;9759.219262459023;9775.804483910317;9776.90223097767;9655.08276713711;9686.273529485317;9704.854427183598;9708.902910970906;9716.854247186298;9667;9726.076022777825;9772.609095636237;9772.853407198898;10078.042585954323;33113;38747.806260968515;39896.60103398958;40155.39766903499;40275.59724402777;3236.5468834362973;3366.9326613467592;3396.813175275359;3564.803935783531;4006.9198616027807;30444.93442729494;31147.377052458825;31356.686433135605;31430.05709828709;32170.839145804122;3222.5609148686285;3277.8033318001;3283.3433313337428;3339.5157702133056;3389.9322013559836;430840;462322;476169;477157;477577;59781.701091494266;60094.69952650296;60117.79764404688;60212;60566;34338.82830585831;34695.306093878484;35135.12162195965;35831.4625280621;35902.64097358993;15938.442154524537;15949.282282297092;16110;16155.43455979035;16165.919170404073;12354.135210535176;12377.195482293622;12396.256224626552;12399.814002789966;12433.316167610687;18653.802894348664;18695.532611684546;18730.71903921415;18739.81260187408;18741.250349985847;7873;7978.361731061501;8006.279434850891;8064.233897779702;8111.797205069803;837.7486753973783;846.3905987688854;918.2286879021653;921.2454760266754;1047.9004494573155;28824.42351152965;30019.249518761768;30174;30273;30402.391952161277;1016.8169729448622;1070.7376692710336;1089.983650245247;1139.5783560082823;1174.9823752643717;13177.879880210097;13711.382987765575;15207.543773686808;15447.22763861825;15791;665021;671633;672232;672296;673914;57135;57293.71353143208;57757.42242577604;57898;58295.41704582985;1147.5581900968186;1308.4046758724758;1318.228836130855;1343.5834891183765;1347.6226656536185;28609.570856436752;29309;29412.11763647094;29905.700942991163;30055.098347049625;49660.751696241285;50285.99428011492;50372;50581.241281381546;50691.49308506868;513733;514545;514575;514859;515000;21974.340769776933;26424.735752642227;26525;26814.731852682005;26870.865645672427;46770.76614617041;47468;47812.52187478081;48021.75989120032;48257;38569.807150964065;39117;39293.607063929;40513.59486405098;40521.79739101286;38064.23871522499;38095.61904380921;38439.807800960814;39681.80954571367;39859.80070099631;32297.35405291834;36486.087847802955;37099;37771.43342849804;37860.24279514449;30758.308293044098;33421.99734007983;33875.49186762151;34140;34961.65038349584;24222.788860557255;25575.872120639277;25622;25633.35916602025;26112.34719132037 10:20:33 INFO - PROCESS | 1649 | |2;jquery.html;297.6606668398027;320.82098288788694;327.1135223544195;350.57755404737287;357.7442128877852;16035.839641603596;18355.174017169225;20790.6881396779;21229.893850530763;21474.463138421546;20149.39551813448;20247.291344802936;20731.896340518313;21159.788402115973;21348.25281115161;5830.912536311958;6054.6367217966845;6066.817995460121;6089.391060893898;6097.3292937776805;3851.672607828324;5150.150225212854;5698.401667824881;5813.040848260032;6085.752420753734;6057.273127224717;6091.238595175603;6116.4800991915745;6167.136600875859;6172.351903050182;5479.890402191953;6036.758529658809;6060.454609064182;6112.480439162677;6119.112728654321;5657.1514272858985;5856.414358564152;5857.150713146612;5866.76532938682;5878;12449.564265250763;12786.424610892533;12804.61586152417;12806.039547033917;12835.87164128356;2041.1223174035158;2080.5630817528336;2118.163325486424;2120.0883620043373;2243.540074284768;9465.384749991297;9648.807023859483;9765.462899540522;10227.232957528215;10242.53908574116;1791.2387235424892;1841.3187120765404;1902.838258748008;1930.787613362543;1950.161430584848;71490;106915;122542;123485.14772278423;124200;8902.287816974627;9319.860202096974;9524.333296669305;9553.187979021723;9695.70912872615;11617.59338423168;11642.35967021805;11657.242279251821;11671.12466565011;11681.941590291994;7498.250174982458;7500.662470188855;7703.34521565662;7746.9612651937505;7901;7976.481528700616;8041.6381262843315;8095.069067057364;8159.714409995621;8389.706360277361;3593.8921832345072;3633.691136253448;3694.094946738013;3765.058735316171;3775.188334508039;1526.206372686197;1618.4820857325778;1841.2358871068625;1879.0792511669456;1892.6214757048645;806.7015204374302;875.7022612311845;958.8082383523323;977.5258999385293;982.7346616413671;19980.700289495668;20835.958202089834;20907.37277881666;20931.05810238543;21026.684599731016;832.966681332752;891.8305521950808;947.3842002698301;1042.3485321673954;1043.3166276089173;8625.921759780027;10534.683959481228;10962;10981.682198136115;11001.064909482624;434712;490765;499183;500775;508601;123247;123373;123601;124693.37653311675;126469;933.3140141995764;940.9858852117223;970.8640790289365;970.9757256068655;976.306822156277;18212.36256731008;18274.086295684898;18468.81531184671;18470.81529184691;18490.260389584804;48952.51047489622;49950.25074623956;51263;51263;52315.73842130765;75599.62200189184;76179;76739.08152296237;76849.61575192088;78274.4345113106;6887.173539175331;6900.551464154814;7094.361507464353;7114.466415018997;7258.818529536804;9864;12359.196652217577;12376.133670642968;12647.873521265037;12652.17760845542;8013.559254240839;10448.791024179322;10486.52810623539;10964.725881853017;11284.43577821122;9343.906560934303;9870.950645246729;10937.398443085707;10974.945125274322;11322.32066076038;10825;11017.228793984345;11196.04833589154;11413.372264525531;11574.594889178838;6953.304669533006;7819;7963.203679631991;8057.670484370014;8058.3150432213915;8658;10738;10998.890011099787;11062.834057488983;11072.224944253825 10:20:33 INFO - PROCESS | 1649 | |3;mootools.html;1525.9465918692847;1574.1184936435598;1650.7523871419294;1810.0135426192724;1853.267959156134;7999.920000799991;8599.871001934976;8728.039915609277;9136.13206745359;9140.994490606035;8822.029576746569;8910.420822646523;8920.46477211366;8924.241439477635;8930.062343453925;2300.7929286364224;2303.216906251874;2334.2063698342645;2339.3449834046496;2340.262817212581;2205.647096464566;2289.6794448777187;2320.1183550250967;2329.5224478981854;2340.789328960393;2125.2455378340696;2305.4927915858484;2326.1393284484766;2327.045911176418;2345.5191685704476;2294.3346429535413;2305.792478676927;2308.203669733939;2310.4685922237895;2313.5835549601065;2278.3734473019886;2296.391456264075;2311.3528212100637;2311.6070268054473;2315.4674424882205;8878.955605221998;8941.239994600402;8942;8958.731238062868;8964.327675424369;4672.719636821767;5128.948565544092;5136.255242989746;5199.9600079983775;5312.521873031407;3016.2007068126964;3420.4185288501017;3509.210427653783;3525.982370088159;3573.0888623401124;1039.3763741754963;1044.639599338227;1046.1526163807264;1047.1047254597286;1059.4702648675661;11642.883571164264;11653.126015548867;11715.4142292885;11773.352465614387;11791.469383877746;4525.773711314421;4591.563801438858;4749.145153872336;4756.904861902743;4779.259214821708;9232.53837308132;9523.095305945924;9957.103860652576;10063.345882517759;10093.192544596415;4887.804487820447;5108.233764935289;5341.813036543703;5344.75948582307;5350.438203988603;4391.429114215131;4740.620750339965;4873.488283730228;4905.092557876804;4911.336969509142;3877.9806100969313;3887.1448281378052;4004.6596039336982;4031.8588849390717;4070.1249231414795;1080.2654195147375;1271.7456508698297;1271.8918891894107;1274.7004453953314;1278.5972418688084;877.3288434347729;900.1853322742928;914.3553794574809;928.2944961829058;942.1892511083181;5866.5893387462465;6049.818505444844;6063.333033366326;6137.631742095488;6378.712957916905;912.0970239462883;959.8128364968903;960.5533426956499;974.848898420746;1010.1262408017012;3454.4127498325347;3860.401637746154;3906.882793516199;3996.3805610130476;4081.387791831249;10670.30643008202;10960.835587466194;10976.945115274531;10982.725431864108;10989.945050274697;10888.727781805359;10894.291871028357;10963.725906852393;10977.28647637901;11015.284006539548;7775.883361749465;8262.17378262169;8374.665013399395;8384.245417912418;8406.411551191359;5971.581989260884;6074.817755467343;6098.847528811815;6110.327863935053;6228.28374736893;10034.397936123563;10095.697129086138;10161.644342448275;10194.592216311265;10320.741981450223;10312.639057632947;10330.690079297634;10377.221708372053;10448.32085914413;10472.26694131434;6956.582605043714;7319.926800732138;7440.962795185989;7507.136679281734;7625.8856117157175;8411.11683273272;8544.359173061921;8552.914470855461;8554.700585479479;8580.957095214484;7345.3021962913435;7407.333339999426;7532.209118042527;7615.086189657277;7645.273698998586;6417.93582064192;7252.492325537161;7412.96293518529;7430.848218526137;7501.5874126923545;6775.525713200226;6783.93216067833;6810.387065164159;6844.93155068443;6862.107925969592;5014.648974571891;5053.166227572557;5078.0097880914345;5089.9745501272255;5110.897782044264;4338.4360033196745;4968.850934471971;5117.130087884994;5175.378954525481;5235.895282094413 10:20:33 INFO - PROCESS | 1649 | |4;prototype.html;288.47497554450905;292.5494738103321;300.469671030631;300.6287235264448;302.9757619390449;5316.441773613773;5423.240746295522;5468.316460442445;5610.607257491972;5610.775568977241;4823.638227132961;5499.560035197184;5513.7794488220425;5561.833145005646;5571.693556854371;3262.4453842846774;4097.770668799363;4209.557996410379;4216.683748718843;4226.218149642311;3733.2906747717984;3879.321118804212;4132.318167502359;4204.390363397306;4240.406343111967;4057.788505264638;4063.7358571692894;4083.203775263825;4089.325261331877;4100.708276892769;3528.383407007812;3719.981400093009;4063;4078.143589846136;4114.156597897424;2775.139706690932;2969.5300826091225;3162.8418579070953;3320.452125399306;3537.8054207018604;4450.46594408673;5128.794848206067;5281.419043905167;5332.146856502941;5336.519713225828;4647.837325693585;4653.139169253665;4678.649101317381;4694.765261736899;4710.26990816424;5026.235570436245;5082.923756143661;5466.949893789829;5808.738606762706;5810.796622118206;3191.9945217256723;3421.9486707699402;3797.626483447845;3824.5028146341074;3866.3040652682507;5222.791088356499;6044.848878778022;6084.756609735606;6144.600600960924;6152.969235153795;3899.5515515715488;3902.2780785554196;3906.824192911326;3921.5882332355263;3935.5670876203594;3493.982530087384;3801.6388443097862;3936.901577460529;3971.146203566247;3984.442178095069;4135.593898074609;4178.080822219107;4465.464144302705;4605.861824145281;4674.135284972223;5316.574674026068;5824.039653035976;5826.271716035496;5854.560907931922;5878.442877348367;1252.1485389934749;1310.829592153033;1324.0202250334876;1341.53716967646;1345.0248569786827;811.5009269299338;862.8619420892752;864.6152462154281;881.1805021330224;886.7073865624458;4781.804548862784;4859.878503037382;5107.693538387709;5332.027639408665;5376.870857120049;4529.909401811945;5144.4246248857435;5756.539476841843;5846.970765146147;5855.970720146372;4452.376667266585;4527.024327887158;4665.5567721066445;5123.3339665843205;5301.310829592206;2289.202975664096;2487.962680559793;2554.69343678756;2583.418730785558;2590.8056895732893;4217.873463796091;4363.694541382073;4620.5379462053525;5069.721165335942;5114.872128196825;4451.532589078165;4673.95326046742;4927.901441971212;5063.215201643751;5324.75190134018;4357.731701224082;4406.471223453206;5093.490650934951;5119.769610367543;5192.45479224676;4462.620677242341;4695.347128872177;4729.621630269501;4935.087008903364;4958.7354874806915;4219.493660760729;4276.273033584236;4366.19225443294;4870.537298956593;4931.48219436954;4212.662986961097;5080.517350851663;5108.157154069686;5110.463401342954;5116.488351164854;3052.4200401923563;3064.988553777293;3077.430675325072;3391.6608339165887;3408.8125153116816;4488.349189367589;4614.155137105959;4916.655834091579;4948.525737131435;5609.579281553818;4490.842820501398;5416.458354164552;5732.33446447404;5732.340780810094;5757.7121143941795;4801.735904525284;5000.449950505369;5757.769689212385;5769.423057694197;5829.766809327749;4196.580341965779;4877.3903262092235;5522.631194970984;5624.29696287964;5647.830565083054;5509.614326997072;5717.7141142941855;5724.971375143097;5787.787777783371;5814.912776308443;4867.415910090812;5664.5751568631695;5665.603407761582;5680.630759000652;5687.606536398609 10:20:33 INFO - PROCESS | 1649 | |5;yui.html;711.8576284743052;758.5410826449997;771.6110604197248;778.2412148155547;811.6956141446959;15620.06279623222;16335.673286534262;16341.5914602135;16364.590885227875;16406.589835254108;14589;14727.337269822858;14733.631659208526;14789.334479948402;14792.778108328384;659.5482094765101;806.657170702452;817.8854960305547;828.1511450762956;828.3083625172987;825.5665775467868;846.2806614377761;848.1899785704668;848.2832006954114;848.3764433141636;904.1004200820194;905.0180554098811;905.7690288976302;906.3927168796922;906.9319801014917;895.2211575928918;901.202435844276;902.1429641840245;902.3818684201277;902.6750369866843;663.4659099424961;665.4776000839366;665.5840099937539;665.9833504162386;666.2704338749062;14500.854991450056;14533.491327803476;14778.852211477855;14796.556103316918;14822.332995015251;14334.49829255971;14429.969706361677;14444.711105777826;14466;14551.78172327416;11558;11866.940665296705;11948.103892208119;11985.58050468238;11989.002749312673;3705.40713485841;3751.6998640108727;3778.9622103778884;3822.140018495816;3915.530136383624;122901.77098229082;124822;125246;125325;125991.11013334808;9496.002919693332;10757.46212689378;10808.297460665031;10833.404162771123;10839.861814509362;22250.666240006412;22461.876906154626;22615.54768904613;22680.65979010316;23089.884550577477;7825.256600622932;7852.960735196401;7875.133735289113;7892.842143157105;7921.841563168704;4214.536400995888;4250.617444430016;4304.849330273425;4315.805788739514;4463.263561512379;3282.7373810095137;3372.15696075981;3383.780054296512;3388.762786604914;3397.4564069749217;542.888707814897;551.170488414941;555.3474667265947;569.9088145896636;612.10326871134;455.55583306276776;465.60191036663844;555.1727925391139;561.2815596037079;611.8317462697794;7497.775066748006;8307.83384332322;9063.954680226556;9411;9757.365771224848;464.4937018649688;496.81121173953665;546.7621584610707;608.4979891589456;643.7939859244997;3698.4267438547067;4347.3044312910415;4566.611837993742;4613.469451013109;4643.512431194744;91520;106839;121303;145839;148868;129165.35417322854;132354.33822831017;133391;133994;135238;112424;114537;114557;114801.99999999833;116945;8820.338474614558;8824.382293239412;8832.867506987272;8914.86627700572;9102.635894564144;52310.215346769066;55738.32785016456;58008.12987805102;62018.68990655018;62391;92531.07468925494;96080.03919960711;96107;97690;99534.00465995538;11441.989962992713;11468.31190128595;11605.129615278718;11636.41817909118;11668.824967625662;12277.693057673272;12421.813672794735;12605.747885042065;12651.87348126507;13050.934745326213;11821.586244481401;11940.761184776082;11986.460609272777;11996.76006479883;12001;11586.362750048827;11942.582009629621;12071.517139314328;12130.029597632345;12144.939275303566;11909.40452977365;11946.462409191781;11984.460699268728;12311.75376492483;12356.567520136752;10117.140043096419;10222;10279.537420815932;10380.377177369382;10503.028759482186;8719.084496127814;9967.900320996698;10323.48382580853;10337.069663729999;10381.402396475225 10:20:33 INFO - PROCESS | 1649 | __end_tp_report 10:20:33 INFO - PROCESS | 1649 | __start_cc_report 10:20:33 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,386 10:20:33 INFO - PROCESS | 1649 | __end_cc_report 10:20:33 INFO - PROCESS | 1649 | __startTimestamp1472232033479__endTimestamp 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | ------- Summary: start ------- 10:20:33 INFO - PROCESS | 1649 | Number of tests: 6 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5672.26 Median:5860.24 stddev:660.07 (11.3%) stddev-sans-first:637.56 10:20:33 INFO - PROCESS | 1649 | Values: 3399.8 3419.9 3427.8 3446.8 3460.4 5545.8 5636.7 5731.2 5790.3 5792.0 5449.2 5502.3 5711.8 5735.7 5740.9 5151.7 5268.7 5295.4 5340.3 5341.3 5106.9 5186.2 5285.1 5301.9 5380.9 4280.4 5275.4 5279.8 5283.0 5296.0 4535.7 5265.0 5285.2 5293.9 5294.5 4559.8 5162.7 5239.1 5246.2 5271.7 5658.6 5664.7 5667.0 5669.4 5716.7 5080.5 6155.3 6183.4 6238.8 6261.1 6153.6 6155.2 6246.8 6261.6 6262.3 4714.4 5789.4 5826.3 5874.6 5941.6 4595.7 6256.1 6342.9 6362.5 6378.3 4974.9 5414.7 6027.8 6132.4 6132.7 5157.9 5417.5 5887.1 6269.7 6272.7 6106.6 6235.0 6246.0 6255.9 6271.3 6096.4 6099.3 6116.2 6136.5 6262.1 4166.4 4956.8 4969.1 4994.7 5008.1 4407.0 4449.6 4463.8 4481.4 4483.8 5635.0 5855.1 5866.3 5893.0 5901.4 6197.8 6228.3 6238.1 6259.4 6262.0 5906.6 5929.1 5929.5 5935.9 5976.1 5339.3 5418.3 5459.7 5463.5 5475.8 5346.4 6269.1 6387.2 6432.3 6443.0 6213.7 6226.8 6258.9 6259.6 6273.4 6282.6 6314.0 6337.9 6339.8 6455.8 6190.8 6191.3 6192.5 6192.5 6235.0 5019.9 5203.0 6219.6 6256.6 6282.1 5811.4 6096.7 6124.9 6125.6 6150.2 5104.3 6119.0 6146.4 6147.5 6163.3 5860.2 5901.4 5975.5 5996.8 6055.6 5848.9 5886.5 5929.7 5933.9 6175.7 5777.0 5781.9 5803.7 5806.4 5837.7 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:67818.12 Median:39770.81 stddev:149002.09 (374.7%) stddev-sans-first:149334.33 10:20:33 INFO - PROCESS | 1649 | Values: 490.0 501.0 531.3 543.3 559.4 38345.4 40569.6 40736.6 40893.0 40917.6 41628.8 41939.4 42202.4 42208.0 42480.6 9592.8 9794.0 9813.3 9831.4 9854.1 9611.8 9707.3 9731.3 9746.8 9759.9 9720.2 9750.3 9759.2 9775.8 9776.9 9655.1 9686.3 9704.9 9708.9 9716.9 9667.0 9726.1 9772.6 9772.9 10078.0 33113.0 38747.8 39896.6 40155.4 40275.6 3236.5 3366.9 3396.8 3564.8 4006.9 30444.9 31147.4 31356.7 31430.1 32170.8 3222.6 3277.8 3283.3 3339.5 3389.9 430840.0 462322.0 476169.0 477157.0 477577.0 59781.7 60094.7 60117.8 60212.0 60566.0 34338.8 34695.3 35135.1 35831.5 35902.6 15938.4 15949.3 16110.0 16155.4 16165.9 12354.1 12377.2 12396.3 12399.8 12433.3 18653.8 18695.5 18730.7 18739.8 18741.3 7873.0 7978.4 8006.3 8064.2 8111.8 837.7 846.4 918.2 921.2 1047.9 28824.4 30019.2 30174.0 30273.0 30402.4 1016.8 1070.7 1090.0 1139.6 1175.0 13177.9 13711.4 15207.5 15447.2 15791.0 665021.0 671633.0 672232.0 672296.0 673914.0 57135.0 57293.7 57757.4 57898.0 58295.4 1147.6 1308.4 1318.2 1343.6 1347.6 28609.6 29309.0 29412.1 29905.7 30055.1 49660.8 50286.0 50372.0 50581.2 50691.5 513733.0 514545.0 514575.0 514859.0 515000.0 21974.3 26424.7 26525.0 26814.7 26870.9 46770.8 47468.0 47812.5 48021.8 48257.0 38569.8 39117.0 39293.6 40513.6 40521.8 38064.2 38095.6 38439.8 39681.8 39859.8 32297.4 36486.1 37099.0 37771.4 37860.2 30758.3 33422.0 33875.5 34140.0 34961.7 24222.8 25575.9 25622.0 25633.4 26112.3 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:30797.20 Median:3770.12 stddev:82407.38 (2185.8%) stddev-sans-first:82606.73 10:20:33 INFO - PROCESS | 1649 | Values: 297.7 320.8 327.1 350.6 357.7 16035.8 18355.2 20790.7 21229.9 21474.5 20149.4 20247.3 20731.9 21159.8 21348.3 5830.9 6054.6 6066.8 6089.4 6097.3 3851.7 5150.2 5698.4 5813.0 6085.8 6057.3 6091.2 6116.5 6167.1 6172.4 5479.9 6036.8 6060.5 6112.5 6119.1 5657.2 5856.4 5857.2 5866.8 5878.0 12449.6 12786.4 12804.6 12806.0 12835.9 2041.1 2080.6 2118.2 2120.1 2243.5 9465.4 9648.8 9765.5 10227.2 10242.5 1791.2 1841.3 1902.8 1930.8 1950.2 71490.0 106915.0 122542.0 123485.1 124200.0 8902.3 9319.9 9524.3 9553.2 9695.7 11617.6 11642.4 11657.2 11671.1 11681.9 7498.3 7500.7 7703.3 7747.0 7901.0 7976.5 8041.6 8095.1 8159.7 8389.7 3593.9 3633.7 3694.1 3765.1 3775.2 1526.2 1618.5 1841.2 1879.1 1892.6 806.7 875.7 958.8 977.5 982.7 19980.7 20836.0 20907.4 20931.1 21026.7 833.0 891.8 947.4 1042.3 1043.3 8625.9 10534.7 10962.0 10981.7 11001.1 434712.0 490765.0 499183.0 500775.0 508601.0 123247.0 123373.0 123601.0 124693.4 126469.0 933.3 941.0 970.9 971.0 976.3 18212.4 18274.1 18468.8 18470.8 18490.3 48952.5 49950.3 51263.0 51263.0 52315.7 75599.6 76179.0 76739.1 76849.6 78274.4 6887.2 6900.6 7094.4 7114.5 7258.8 9864.0 12359.2 12376.1 12647.9 12652.2 8013.6 10448.8 10486.5 10964.7 11284.4 9343.9 9871.0 10937.4 10974.9 11322.3 10825.0 11017.2 11196.0 11413.4 11574.6 6953.3 7819.0 7963.2 8057.7 8058.3 8658.0 10738.0 10998.9 11062.8 11072.2 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5741.78 Median:4768.08 stddev:3259.72 (68.4%) stddev-sans-first:3253.47 10:20:33 INFO - PROCESS | 1649 | Values: 1525.9 1574.1 1650.8 1810.0 1853.3 7999.9 8599.9 8728.0 9136.1 9141.0 8822.0 8910.4 8920.5 8924.2 8930.1 2300.8 2303.2 2334.2 2339.3 2340.3 2205.6 2289.7 2320.1 2329.5 2340.8 2125.2 2305.5 2326.1 2327.0 2345.5 2294.3 2305.8 2308.2 2310.5 2313.6 2278.4 2296.4 2311.4 2311.6 2315.5 8879.0 8941.2 8942.0 8958.7 8964.3 4672.7 5128.9 5136.3 5200.0 5312.5 3016.2 3420.4 3509.2 3526.0 3573.1 1039.4 1044.6 1046.2 1047.1 1059.5 11642.9 11653.1 11715.4 11773.4 11791.5 4525.8 4591.6 4749.1 4756.9 4779.3 9232.5 9523.1 9957.1 10063.3 10093.2 4887.8 5108.2 5341.8 5344.8 5350.4 4391.4 4740.6 4873.5 4905.1 4911.3 3878.0 3887.1 4004.7 4031.9 4070.1 1080.3 1271.7 1271.9 1274.7 1278.6 877.3 900.2 914.4 928.3 942.2 5866.6 6049.8 6063.3 6137.6 6378.7 912.1 959.8 960.6 974.8 1010.1 3454.4 3860.4 3906.9 3996.4 4081.4 10670.3 10960.8 10976.9 10982.7 10989.9 10888.7 10894.3 10963.7 10977.3 11015.3 7775.9 8262.2 8374.7 8384.2 8406.4 5971.6 6074.8 6098.8 6110.3 6228.3 10034.4 10095.7 10161.6 10194.6 10320.7 10312.6 10330.7 10377.2 10448.3 10472.3 6956.6 7319.9 7441.0 7507.1 7625.9 8411.1 8544.4 8552.9 8554.7 8581.0 7345.3 7407.3 7532.2 7615.1 7645.3 6417.9 7252.5 7413.0 7430.8 7501.6 6775.5 6783.9 6810.4 6844.9 6862.1 5014.6 5053.2 5078.0 5090.0 5110.9 4338.4 4968.9 5117.1 5175.4 5235.9 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4361.65 Median:4702.81 stddev:1366.15 (29.0%) stddev-sans-first:1335.33 10:20:33 INFO - PROCESS | 1649 | Values: 288.5 292.5 300.5 300.6 303.0 5316.4 5423.2 5468.3 5610.6 5610.8 4823.6 5499.6 5513.8 5561.8 5571.7 3262.4 4097.8 4209.6 4216.7 4226.2 3733.3 3879.3 4132.3 4204.4 4240.4 4057.8 4063.7 4083.2 4089.3 4100.7 3528.4 3720.0 4063.0 4078.1 4114.2 2775.1 2969.5 3162.8 3320.5 3537.8 4450.5 5128.8 5281.4 5332.1 5336.5 4647.8 4653.1 4678.6 4694.8 4710.3 5026.2 5082.9 5466.9 5808.7 5810.8 3192.0 3421.9 3797.6 3824.5 3866.3 5222.8 6044.8 6084.8 6144.6 6153.0 3899.6 3902.3 3906.8 3921.6 3935.6 3494.0 3801.6 3936.9 3971.1 3984.4 4135.6 4178.1 4465.5 4605.9 4674.1 5316.6 5824.0 5826.3 5854.6 5878.4 1252.1 1310.8 1324.0 1341.5 1345.0 811.5 862.9 864.6 881.2 886.7 4781.8 4859.9 5107.7 5332.0 5376.9 4529.9 5144.4 5756.5 5847.0 5856.0 4452.4 4527.0 4665.6 5123.3 5301.3 2289.2 2488.0 2554.7 2583.4 2590.8 4217.9 4363.7 4620.5 5069.7 5114.9 4451.5 4674.0 4927.9 5063.2 5324.8 4357.7 4406.5 5093.5 5119.8 5192.5 4462.6 4695.3 4729.6 4935.1 4958.7 4219.5 4276.3 4366.2 4870.5 4931.5 4212.7 5080.5 5108.2 5110.5 5116.5 3052.4 3065.0 3077.4 3391.7 3408.8 4488.3 4614.2 4916.7 4948.5 5609.6 4490.8 5416.5 5732.3 5732.3 5757.7 4801.7 5000.4 5757.8 5769.4 5829.8 4196.6 4877.4 5522.6 5624.3 5647.8 5509.6 5717.7 5725.0 5787.8 5814.9 4867.4 5664.6 5665.6 5680.6 5687.6 10:20:33 INFO - PROCESS | 1649 | 10:20:33 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:24532.83 Median:3547.94 stddev:39507.48 (1113.5%) stddev-sans-first:39577.82 10:20:33 INFO - PROCESS | 1649 | Values: 711.9 758.5 771.6 778.2 811.7 15620.1 16335.7 16341.6 16364.6 16406.6 14589.0 14727.3 14733.6 14789.3 14792.8 659.5 806.7 817.9 828.2 828.3 825.6 846.3 848.2 848.3 848.4 904.1 905.0 905.8 906.4 906.9 895.2 901.2 902.1 902.4 902.7 663.5 665.5 665.6 666.0 666.3 14500.9 14533.5 14778.9 14796.6 14822.3 14334.5 14430.0 14444.7 14466.0 14551.8 11558.0 11866.9 11948.1 11985.6 11989.0 3705.4 3751.7 3779.0 3822.1 3915.5 122901.8 124822.0 125246.0 125325.0 125991.1 9496.0 10757.5 10808.3 10833.4 10839.9 22250.7 22461.9 22615.5 22680.7 23089.9 7825.3 7853.0 7875.1 7892.8 7921.8 4214.5 4250.6 4304.8 4315.8 4463.3 3282.7 3372.2 3383.8 3388.8 3397.5 542.9 551.2 555.3 569.9 612.1 455.6 465.6 555.2 561.3 611.8 7497.8 8307.8 9064.0 9411.0 9757.4 464.5 496.8 546.8 608.5 643.8 3698.4 4347.3 4566.6 4613.5 4643.5 91520.0 106839.0 121303.0 145839.0 148868.0 129165.4 132354.3 133391.0 133994.0 135238.0 112424.0 114537.0 114557.0 114802.0 116945.0 8820.3 8824.4 8832.9 8914.9 9102.6 52310.2 55738.3 58008.1 62018.7 62391.0 92531.1 96080.0 96107.0 97690.0 99534.0 11442.0 11468.3 11605.1 11636.4 11668.8 12277.7 12421.8 12605.7 12651.9 13050.9 11821.6 11940.8 11986.5 11996.8 12001.0 11586.4 11942.6 12071.5 12130.0 12144.9 11909.4 11946.5 11984.5 12311.8 12356.6 10117.1 10222.0 10279.5 10380.4 10503.0 8719.1 9967.9 10323.5 10337.1 10381.4 10:20:33 INFO - PROCESS | 1649 | -------- Summary: end -------- 10:20:33 INFO - PROCESS | 1649 | 10:20:34 INFO - TEST-INFO | 1649: exit 0 10:20:34 INFO - TEST-OK | dromaeo_css | took 1114258ms 10:20:34 INFO - TEST-START | kraken 10:20:34 INFO - operating with platform_type : mac_ 10:20:34 INFO - Initialising browser for kraken test... 10:20:34 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp3VZlo7/profile http://localhost:49271/getInfo.html) 10:20:36 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 10:20:36 INFO - PROCESS | 1658 | colorDepth:24 10:20:36 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 10:20:36 INFO - PROCESS | 1658 | __metrics 10:20:36 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 10:20:37 INFO - TEST-INFO | 1658: exit 0 10:20:37 INFO - Browser initialized. 10:20:37 INFO - Running cycle 1/1 for kraken test... 10:20:37 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/tmp3VZlo7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:49 INFO - PROCESS | 1660 | RSS: Main: 244113408 10:20:49 INFO - PROCESS | 1660 | 10:20:52 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:53 INFO - PROCESS | 1660 | RSS: Main: 256892928 10:20:53 INFO - PROCESS | 1660 | 10:20:56 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 10:20:56 INFO - PROCESS | 1660 | RSS: Main: 265621504 10:20:56 INFO - PROCESS | 1660 | 10:21:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 10:21:00 INFO - PROCESS | 1660 | RSS: Main: 264261632 10:21:00 INFO - PROCESS | 1660 | 10:21:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 10:21:03 INFO - PROCESS | 1660 | RSS: Main: 266653696 10:21:03 INFO - PROCESS | 1660 | 10:21:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:06 INFO - PROCESS | 1660 | RSS: Main: 267067392 10:21:06 INFO - PROCESS | 1660 | 10:21:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:09 INFO - PROCESS | 1660 | RSS: Main: 267120640 10:21:09 INFO - PROCESS | 1660 | 10:21:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:13 INFO - PROCESS | 1660 | RSS: Main: 267472896 10:21:13 INFO - PROCESS | 1660 | 10:21:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 10:21:16 INFO - PROCESS | 1660 | RSS: Main: 267653120 10:21:16 INFO - PROCESS | 1660 | 10:21:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:19 INFO - PROCESS | 1660 | RSS: Main: 267874304 10:21:19 INFO - PROCESS | 1660 | 10:21:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:21 INFO - PROCESS | 1660 | RSS: Main: 267796480 10:21:21 INFO - PROCESS | 1660 | 10:21:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:24 INFO - PROCESS | 1660 | RSS: Main: 267857920 10:21:24 INFO - PROCESS | 1660 | 10:21:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:28 INFO - PROCESS | 1660 | RSS: Main: 268001280 10:21:28 INFO - PROCESS | 1660 | 10:21:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:32 INFO - PROCESS | 1660 | RSS: Main: 268025856 10:21:32 INFO - PROCESS | 1660 | 10:21:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 10:21:34 INFO - PROCESS | 1660 | RSS: Main: 270102528 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | __start_tp_report 10:21:34 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 10:21:34 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 10:21:34 INFO - PROCESS | 1660 | |i|pagename|runs| 10:21:34 INFO - PROCESS | 1660 | |0;ai-astar;131;121;119;115;118;119;118;118;120;136 10:21:34 INFO - PROCESS | 1660 | |1;audio-beat-detection;145;110;132;173;97;155;162;139;179;114 10:21:34 INFO - PROCESS | 1660 | |2;audio-dft;202;247;272;274;215;202;196;202;195;200 10:21:34 INFO - PROCESS | 1660 | |3;audio-fft;73;80;75;150;60;68;80;85;164;84 10:21:34 INFO - PROCESS | 1660 | |4;audio-oscillator;70;73;120;72;69;82;125;102;105;146 10:21:34 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;97;90;93;88;93;89;94;93;136;132 10:21:34 INFO - PROCESS | 1660 | |6;imaging-darkroom;103;104;103;102;103;102;102;132;131;103 10:21:34 INFO - PROCESS | 1660 | |7;imaging-desaturate;91;92;90;90;95;92;89;95;91;132 10:21:34 INFO - PROCESS | 1660 | |8;json-parse-financial;56;56;57;58;60;58;67;72;79;82 10:21:34 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;68;69;71;71;82;75;74;70;69;67 10:21:34 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;91;89;88;89;88;98;77;90;77;91 10:21:34 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;144;135;154;139;164;157;158;135;175;168 10:21:34 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;169;217;226;192;176;151;224;176;188;175 10:21:34 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;72;68;91;67;68;72;67;62;76 10:21:34 INFO - PROCESS | 1660 | __end_tp_report 10:21:34 INFO - PROCESS | 1660 | __start_cc_report 10:21:34 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,980 10:21:34 INFO - PROCESS | 1660 | __end_cc_report 10:21:34 INFO - PROCESS | 1660 | __startTimestamp1472232094145__endTimestamp 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | ------- Summary: start ------- 10:21:34 INFO - PROCESS | 1660 | Number of tests: 14 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:121.50 Median:119.50 stddev:6.62 (5.5%) stddev-sans-first:6.06 10:21:34 INFO - PROCESS | 1660 | Values: 131.0 121.0 119.0 115.0 118.0 119.0 118.0 118.0 120.0 136.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:158.50 stddev:27.55 (17.4%) stddev-sans-first:29.17 10:21:34 INFO - PROCESS | 1660 | Values: 145.0 110.0 132.0 173.0 97.0 155.0 162.0 139.0 179.0 114.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:220.50 Median:208.50 stddev:31.53 (15.1%) stddev-sans-first:32.72 10:21:34 INFO - PROCESS | 1660 | Values: 202.0 247.0 272.0 274.0 215.0 202.0 196.0 202.0 195.0 200.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:91.90 Median:77.50 stddev:35.27 (45.5%) stddev-sans-first:36.75 10:21:34 INFO - PROCESS | 1660 | Values: 73.0 80.0 75.0 150.0 60.0 68.0 80.0 85.0 164.0 84.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:69.50 stddev:27.36 (39.4%) stddev-sans-first:27.30 10:21:34 INFO - PROCESS | 1660 | Values: 70.0 73.0 120.0 72.0 69.0 82.0 125.0 102.0 105.0 146.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:100.50 Median:93.00 stddev:17.87 (19.2%) stddev-sans-first:18.91 10:21:34 INFO - PROCESS | 1660 | Values: 97.0 90.0 93.0 88.0 93.0 89.0 94.0 93.0 136.0 132.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:103.00 stddev:12.14 (11.8%) stddev-sans-first:12.71 10:21:34 INFO - PROCESS | 1660 | Values: 103.0 104.0 103.0 102.0 103.0 102.0 102.0 132.0 131.0 103.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:91.50 stddev:12.91 (14.1%) stddev-sans-first:13.58 10:21:34 INFO - PROCESS | 1660 | Values: 91.0 92.0 90.0 90.0 95.0 92.0 89.0 95.0 91.0 132.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:63.50 stddev:9.91 (15.6%) stddev-sans-first:10.03 10:21:34 INFO - PROCESS | 1660 | Values: 56.0 56.0 57.0 58.0 60.0 58.0 67.0 72.0 79.0 82.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.00 stddev:4.43 (6.2%) stddev-sans-first:4.50 10:21:34 INFO - PROCESS | 1660 | Values: 68.0 69.0 71.0 71.0 82.0 75.0 74.0 70.0 69.0 67.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:89.50 stddev:6.37 (7.1%) stddev-sans-first:6.65 10:21:34 INFO - PROCESS | 1660 | Values: 91.0 89.0 88.0 89.0 88.0 98.0 77.0 90.0 77.0 91.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:157.50 stddev:14.13 (9.0%) stddev-sans-first:14.62 10:21:34 INFO - PROCESS | 1660 | Values: 144.0 135.0 154.0 139.0 164.0 157.0 158.0 135.0 175.0 168.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:190.00 stddev:25.31 (13.3%) stddev-sans-first:25.74 10:21:34 INFO - PROCESS | 1660 | Values: 169.0 217.0 226.0 192.0 176.0 151.0 224.0 176.0 188.0 175.0 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:70.50 stddev:7.90 (11.2%) stddev-sans-first:8.34 10:21:34 INFO - PROCESS | 1660 | Values: 69.0 72.0 68.0 91.0 67.0 68.0 72.0 67.0 62.0 76.0 10:21:34 INFO - PROCESS | 1660 | -------- Summary: end -------- 10:21:34 INFO - PROCESS | 1660 | 10:21:34 INFO - TEST-INFO | 1660: exit 0 10:21:34 INFO - TEST-OK | kraken | took 60895ms 10:21:34 INFO - SUITE-END | took 1175s 10:21:35 INFO - Completed test suite (00:19:35) 10:21:35 INFO - javascript benchmark 10:21:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7144.9537682248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.7790143640646, 3419.9316013679727, 3427.8114703691294, 3446.758726889118, 3460.359833430814, 5545.805896793613, 5636.66180029198, 5731.197632331472, 5790.33411157717, 5792.015357389243, 5449.155380915954, 5502.339719233688, 5711.828645140642, 5735.741891614877, 5740.913886291709, 5151.71665558395, 5268.710220937847, 5295.443978382272, 5340.279062326575, 5341.278927344817, 5106.897862042757, 5186.222066689989, 5285.075111855429, 5301.920471192935, 5380.91928621071, 4280.357946308063, 5275.446078161776, 5279.762410691528, 5283.049051170788, 5296.0, 4535.705179163377, 5265.0, 5285.154375299972, 5293.947060529384, 5294.549963253128, 4559.817607295704, 5162.664426812245, 5239.13554263546, 5246.160614301693, 5271.736413179326, 5658.603897727161, 5664.716764161775, 5666.971665141689, 5669.433056694339, 5716.685582292972, 5080.466551012164, 6155.261368635747, 6183.443490085869, 6238.814625221194, 6261.092141639482, 6153.630782153085, 6155.169052177944, 6246.812595622138, 6261.624302541862, 6262.311145774007, 4714.4106986626675, 5789.3921138279875, 5826.329972053183, 5874.588778785486, 5941.643501389931, 4595.724256544551, 6256.061590761331, 6342.936570634327, 6362.522810789209, 6378.266499352541, 4974.925376119361, 5414.7021913795115, 6027.758889644453, 6132.448079672851, 6132.724027418777, 5157.896842063213, 5417.51242388187, 5887.087501437284, 6269.717862696099, 6272.717727702265, 6106.633601983806, 6234.9688251558455, 6245.96877015612, 6255.874882502325, 6271.3415091414745, 6096.435975519003, 6099.309783606499, 6116.1836049259855, 6136.519078024374, 6262.12330273762, 4166.395872598457, 4956.752162391866, 4969.130402179604, 4994.725290109006, 5008.098542262428, 4407.030453300269, 4449.57729015743, 4463.776811159429, 4481.395011673448, 4483.775811209492, 5634.97182514093, 5855.063189889683, 5866.325372582122, 5892.970535147297, 5901.439363260483, 6197.81406557804, 6228.34602366754, 6238.1266622672865, 6259.405356491126, 6261.968690156611, 5906.5570082244, 5929.140274660236, 5929.466348028612, 5935.851603709942, 5976.133460648181, 5339.332583427072, 5418.2685337479725, 5459.727013649381, 5463.508284254436, 5475.780968761284, 5346.358436987586, 6269.122322874801, 6387.233531976192, 6432.292447830829, 6443.0, 6213.720382582705, 6226.782062627967, 6258.9374106260175, 6259.624422534663, 6273.404026617464, 6282.623042617458, 6314.0, 6337.936620633919, 6339.841503962438, 6455.838604034937, 6190.81427557174, 6191.288001879661, 6192.535559832941, 6192.535559832941, 6235.033569796688, 5019.949800501949, 5202.97398513005, 6219.626822390671, 6256.562040657111, 6282.120503129657, 5811.4479124483105, 6096.664683442454, 6124.8775024500155, 6125.601835880653, 6150.169727086786, 5104.310918026167, 6119.0, 6146.416090471398, 6147.493864003348, 6163.291221509584, 5860.238169037998, 5901.439363260483, 5975.492083172805, 5996.820095397145, 6055.576109672281, 5848.941510584839, 5886.470217680429, 5929.673867937132, 5933.881322373615, 6175.722092505938, 5776.971115144397, 5781.855453613525, 5803.680797556175, 5806.361300256884, 5837.708114594338], "value": 5635.205520812215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.044413393882, 500.958007344723, 531.3358302122347, 543.3045701502078, 559.3958524793222, 38345.42481862774, 40569.59430405695, 40736.59263407365, 40893.0, 40917.59082409175, 41628.791856040676, 41939.37090943631, 42202.36696449556, 42208.0, 42480.57519424812, 9592.760180995461, 9793.951030244874, 9813.313068085237, 9831.410115393064, 9854.113129818315, 9611.80776384472, 9707.271954603397, 9731.270154738388, 9746.805063898717, 9759.853602195937, 9720.222382209442, 9750.317477776558, 9759.219262459023, 9775.804483910317, 9776.90223097767, 9655.08276713711, 9686.273529485317, 9704.854427183598, 9708.902910970906, 9716.854247186298, 9667.0, 9726.076022777825, 9772.609095636237, 9772.853407198898, 10078.042585954323, 33113.0, 38747.806260968515, 39896.60103398958, 40155.39766903499, 40275.59724402777, 3236.5468834362973, 3366.9326613467592, 3396.813175275359, 3564.803935783531, 4006.9198616027807, 30444.93442729494, 31147.377052458825, 31356.686433135605, 31430.05709828709, 32170.839145804122, 3222.5609148686285, 3277.8033318001, 3283.3433313337428, 3339.5157702133056, 3389.9322013559836, 430840.0, 462322.0, 476169.0, 477157.0, 477577.0, 59781.701091494266, 60094.69952650296, 60117.79764404688, 60212.0, 60566.0, 34338.82830585831, 34695.306093878484, 35135.12162195965, 35831.4625280621, 35902.64097358993, 15938.442154524537, 15949.282282297092, 16110.0, 16155.43455979035, 16165.919170404073, 12354.135210535176, 12377.195482293622, 12396.256224626552, 12399.814002789966, 12433.316167610687, 18653.802894348664, 18695.532611684546, 18730.71903921415, 18739.81260187408, 18741.250349985847, 7873.0, 7978.361731061501, 8006.279434850891, 8064.233897779702, 8111.797205069803, 837.7486753973783, 846.3905987688854, 918.2286879021653, 921.2454760266754, 1047.9004494573155, 28824.42351152965, 30019.249518761768, 30174.0, 30273.0, 30402.391952161277, 1016.8169729448622, 1070.7376692710336, 1089.983650245247, 1139.5783560082823, 1174.9823752643717, 13177.879880210097, 13711.382987765575, 15207.543773686808, 15447.22763861825, 15791.0, 665021.0, 671633.0, 672232.0, 672296.0, 673914.0, 57135.0, 57293.71353143208, 57757.42242577604, 57898.0, 58295.41704582985, 1147.5581900968186, 1308.4046758724758, 1318.228836130855, 1343.5834891183765, 1347.6226656536185, 28609.570856436752, 29309.0, 29412.11763647094, 29905.700942991163, 30055.098347049625, 49660.751696241285, 50285.99428011492, 50372.0, 50581.241281381546, 50691.49308506868, 513733.0, 514545.0, 514575.0, 514859.0, 515000.0, 21974.340769776933, 26424.735752642227, 26525.0, 26814.731852682005, 26870.865645672427, 46770.76614617041, 47468.0, 47812.52187478081, 48021.75989120032, 48257.0, 38569.807150964065, 39117.0, 39293.607063929, 40513.59486405098, 40521.79739101286, 38064.23871522499, 38095.61904380921, 38439.807800960814, 39681.80954571367, 39859.80070099631, 32297.35405291834, 36486.087847802955, 37099.0, 37771.43342849804, 37860.24279514449, 30758.308293044098, 33421.99734007983, 33875.49186762151, 34140.0, 34961.65038349584, 24222.788860557255, 25575.872120639277, 25622.0, 25633.35916602025, 26112.34719132037], "value": 19573.365318422075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6606668398027, 320.82098288788694, 327.1135223544195, 350.57755404737287, 357.7442128877852, 16035.839641603596, 18355.174017169225, 20790.6881396779, 21229.893850530763, 21474.463138421546, 20149.39551813448, 20247.291344802936, 20731.896340518313, 21159.788402115973, 21348.25281115161, 5830.912536311958, 6054.6367217966845, 6066.817995460121, 6089.391060893898, 6097.3292937776805, 3851.672607828324, 5150.150225212854, 5698.401667824881, 5813.040848260032, 6085.752420753734, 6057.273127224717, 6091.238595175603, 6116.4800991915745, 6167.136600875859, 6172.351903050182, 5479.890402191953, 6036.758529658809, 6060.454609064182, 6112.480439162677, 6119.112728654321, 5657.1514272858985, 5856.414358564152, 5857.150713146612, 5866.76532938682, 5878.0, 12449.564265250763, 12786.424610892533, 12804.61586152417, 12806.039547033917, 12835.87164128356, 2041.1223174035158, 2080.5630817528336, 2118.163325486424, 2120.0883620043373, 2243.540074284768, 9465.384749991297, 9648.807023859483, 9765.462899540522, 10227.232957528215, 10242.53908574116, 1791.2387235424892, 1841.3187120765404, 1902.838258748008, 1930.787613362543, 1950.161430584848, 71490.0, 106915.0, 122542.0, 123485.14772278423, 124200.0, 8902.287816974627, 9319.860202096974, 9524.333296669305, 9553.187979021723, 9695.70912872615, 11617.59338423168, 11642.35967021805, 11657.242279251821, 11671.12466565011, 11681.941590291994, 7498.250174982458, 7500.662470188855, 7703.34521565662, 7746.9612651937505, 7901.0, 7976.481528700616, 8041.6381262843315, 8095.069067057364, 8159.714409995621, 8389.706360277361, 3593.8921832345072, 3633.691136253448, 3694.094946738013, 3765.058735316171, 3775.188334508039, 1526.206372686197, 1618.4820857325778, 1841.2358871068625, 1879.0792511669456, 1892.6214757048645, 806.7015204374302, 875.7022612311845, 958.8082383523323, 977.5258999385293, 982.7346616413671, 19980.700289495668, 20835.958202089834, 20907.37277881666, 20931.05810238543, 21026.684599731016, 832.966681332752, 891.8305521950808, 947.3842002698301, 1042.3485321673954, 1043.3166276089173, 8625.921759780027, 10534.683959481228, 10962.0, 10981.682198136115, 11001.064909482624, 434712.0, 490765.0, 499183.0, 500775.0, 508601.0, 123247.0, 123373.0, 123601.0, 124693.37653311675, 126469.0, 933.3140141995764, 940.9858852117223, 970.8640790289365, 970.9757256068655, 976.306822156277, 18212.36256731008, 18274.086295684898, 18468.81531184671, 18470.81529184691, 18490.260389584804, 48952.51047489622, 49950.25074623956, 51263.0, 51263.0, 52315.73842130765, 75599.62200189184, 76179.0, 76739.08152296237, 76849.61575192088, 78274.4345113106, 6887.173539175331, 6900.551464154814, 7094.361507464353, 7114.466415018997, 7258.818529536804, 9864.0, 12359.196652217577, 12376.133670642968, 12647.873521265037, 12652.17760845542, 8013.559254240839, 10448.791024179322, 10486.52810623539, 10964.725881853017, 11284.43577821122, 9343.906560934303, 9870.950645246729, 10937.398443085707, 10974.945125274322, 11322.32066076038, 10825.0, 11017.228793984345, 11196.04833589154, 11413.372264525531, 11574.594889178838, 6953.304669533006, 7819.0, 7963.203679631991, 8057.670484370014, 8058.3150432213915, 8658.0, 10738.0, 10998.890011099787, 11062.834057488983, 11072.224944253825], "value": 8892.389657979178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.9465918692847, 1574.1184936435598, 1650.7523871419294, 1810.0135426192724, 1853.267959156134, 7999.920000799991, 8599.871001934976, 8728.039915609277, 9136.13206745359, 9140.994490606035, 8822.029576746569, 8910.420822646523, 8920.46477211366, 8924.241439477635, 8930.062343453925, 2300.7929286364224, 2303.216906251874, 2334.2063698342645, 2339.3449834046496, 2340.262817212581, 2205.647096464566, 2289.6794448777187, 2320.1183550250967, 2329.5224478981854, 2340.789328960393, 2125.2455378340696, 2305.4927915858484, 2326.1393284484766, 2327.045911176418, 2345.5191685704476, 2294.3346429535413, 2305.792478676927, 2308.203669733939, 2310.4685922237895, 2313.5835549601065, 2278.3734473019886, 2296.391456264075, 2311.3528212100637, 2311.6070268054473, 2315.4674424882205, 8878.955605221998, 8941.239994600402, 8942.0, 8958.731238062868, 8964.327675424369, 4672.719636821767, 5128.948565544092, 5136.255242989746, 5199.9600079983775, 5312.521873031407, 3016.2007068126964, 3420.4185288501017, 3509.210427653783, 3525.982370088159, 3573.0888623401124, 1039.3763741754963, 1044.639599338227, 1046.1526163807264, 1047.1047254597286, 1059.4702648675661, 11642.883571164264, 11653.126015548867, 11715.4142292885, 11773.352465614387, 11791.469383877746, 4525.773711314421, 4591.563801438858, 4749.145153872336, 4756.904861902743, 4779.259214821708, 9232.53837308132, 9523.095305945924, 9957.103860652576, 10063.345882517759, 10093.192544596415, 4887.804487820447, 5108.233764935289, 5341.813036543703, 5344.75948582307, 5350.438203988603, 4391.429114215131, 4740.620750339965, 4873.488283730228, 4905.092557876804, 4911.336969509142, 3877.9806100969313, 3887.1448281378052, 4004.6596039336982, 4031.8588849390717, 4070.1249231414795, 1080.2654195147375, 1271.7456508698297, 1271.8918891894107, 1274.7004453953314, 1278.5972418688084, 877.3288434347729, 900.1853322742928, 914.3553794574809, 928.2944961829058, 942.1892511083181, 5866.5893387462465, 6049.818505444844, 6063.333033366326, 6137.631742095488, 6378.712957916905, 912.0970239462883, 959.8128364968903, 960.5533426956499, 974.848898420746, 1010.1262408017012, 3454.4127498325347, 3860.401637746154, 3906.882793516199, 3996.3805610130476, 4081.387791831249, 10670.30643008202, 10960.835587466194, 10976.945115274531, 10982.725431864108, 10989.945050274697, 10888.727781805359, 10894.291871028357, 10963.725906852393, 10977.28647637901, 11015.284006539548, 7775.883361749465, 8262.17378262169, 8374.665013399395, 8384.245417912418, 8406.411551191359, 5971.581989260884, 6074.817755467343, 6098.847528811815, 6110.327863935053, 6228.28374736893, 10034.397936123563, 10095.697129086138, 10161.644342448275, 10194.592216311265, 10320.741981450223, 10312.639057632947, 10330.690079297634, 10377.221708372053, 10448.32085914413, 10472.26694131434, 6956.582605043714, 7319.926800732138, 7440.962795185989, 7507.136679281734, 7625.8856117157175, 8411.11683273272, 8544.359173061921, 8552.914470855461, 8554.700585479479, 8580.957095214484, 7345.3021962913435, 7407.333339999426, 7532.209118042527, 7615.086189657277, 7645.273698998586, 6417.93582064192, 7252.492325537161, 7412.96293518529, 7430.848218526137, 7501.5874126923545, 6775.525713200226, 6783.93216067833, 6810.387065164159, 6844.93155068443, 6862.107925969592, 5014.648974571891, 5053.166227572557, 5078.0097880914345, 5089.9745501272255, 5110.897782044264, 4338.4360033196745, 4968.850934471971, 5117.130087884994, 5175.378954525481, 5235.895282094413], "value": 4593.792369283021, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.47497554450905, 292.5494738103321, 300.469671030631, 300.6287235264448, 302.9757619390449, 5316.441773613773, 5423.240746295522, 5468.316460442445, 5610.607257491972, 5610.775568977241, 4823.638227132961, 5499.560035197184, 5513.7794488220425, 5561.833145005646, 5571.693556854371, 3262.4453842846774, 4097.770668799363, 4209.557996410379, 4216.683748718843, 4226.218149642311, 3733.2906747717984, 3879.321118804212, 4132.318167502359, 4204.390363397306, 4240.406343111967, 4057.788505264638, 4063.7358571692894, 4083.203775263825, 4089.325261331877, 4100.708276892769, 3528.383407007812, 3719.981400093009, 4063.0, 4078.143589846136, 4114.156597897424, 2775.139706690932, 2969.5300826091225, 3162.8418579070953, 3320.452125399306, 3537.8054207018604, 4450.46594408673, 5128.794848206067, 5281.419043905167, 5332.146856502941, 5336.519713225828, 4647.837325693585, 4653.139169253665, 4678.649101317381, 4694.765261736899, 4710.26990816424, 5026.235570436245, 5082.923756143661, 5466.949893789829, 5808.738606762706, 5810.796622118206, 3191.9945217256723, 3421.9486707699402, 3797.626483447845, 3824.5028146341074, 3866.3040652682507, 5222.791088356499, 6044.848878778022, 6084.756609735606, 6144.600600960924, 6152.969235153795, 3899.5515515715488, 3902.2780785554196, 3906.824192911326, 3921.5882332355263, 3935.5670876203594, 3493.982530087384, 3801.6388443097862, 3936.901577460529, 3971.146203566247, 3984.442178095069, 4135.593898074609, 4178.080822219107, 4465.464144302705, 4605.861824145281, 4674.135284972223, 5316.574674026068, 5824.039653035976, 5826.271716035496, 5854.560907931922, 5878.442877348367, 1252.1485389934749, 1310.829592153033, 1324.0202250334876, 1341.53716967646, 1345.0248569786827, 811.5009269299338, 862.8619420892752, 864.6152462154281, 881.1805021330224, 886.7073865624458, 4781.804548862784, 4859.878503037382, 5107.693538387709, 5332.027639408665, 5376.870857120049, 4529.909401811945, 5144.4246248857435, 5756.539476841843, 5846.970765146147, 5855.970720146372, 4452.376667266585, 4527.024327887158, 4665.5567721066445, 5123.3339665843205, 5301.310829592206, 2289.202975664096, 2487.962680559793, 2554.69343678756, 2583.418730785558, 2590.8056895732893, 4217.873463796091, 4363.694541382073, 4620.5379462053525, 5069.721165335942, 5114.872128196825, 4451.532589078165, 4673.95326046742, 4927.901441971212, 5063.215201643751, 5324.75190134018, 4357.731701224082, 4406.471223453206, 5093.490650934951, 5119.769610367543, 5192.45479224676, 4462.620677242341, 4695.347128872177, 4729.621630269501, 4935.087008903364, 4958.7354874806915, 4219.493660760729, 4276.273033584236, 4366.19225443294, 4870.537298956593, 4931.48219436954, 4212.662986961097, 5080.517350851663, 5108.157154069686, 5110.463401342954, 5116.488351164854, 3052.4200401923563, 3064.988553777293, 3077.430675325072, 3391.6608339165887, 3408.8125153116816, 4488.349189367589, 4614.155137105959, 4916.655834091579, 4948.525737131435, 5609.579281553818, 4490.842820501398, 5416.458354164552, 5732.33446447404, 5732.340780810094, 5757.7121143941795, 4801.735904525284, 5000.449950505369, 5757.769689212385, 5769.423057694197, 5829.766809327749, 4196.580341965779, 4877.3903262092235, 5522.631194970984, 5624.29696287964, 5647.830565083054, 5509.614326997072, 5717.7141142941855, 5724.971375143097, 5787.787777783371, 5814.912776308443, 4867.415910090812, 5664.5751568631695, 5665.603407761582, 5680.630759000652, 5687.606536398609], "value": 3931.3335166127035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8576284743052, 758.5410826449997, 771.6110604197248, 778.2412148155547, 811.6956141446959, 15620.06279623222, 16335.673286534262, 16341.5914602135, 16364.590885227875, 16406.589835254108, 14589.0, 14727.337269822858, 14733.631659208526, 14789.334479948402, 14792.778108328384, 659.5482094765101, 806.657170702452, 817.8854960305547, 828.1511450762956, 828.3083625172987, 825.5665775467868, 846.2806614377761, 848.1899785704668, 848.2832006954114, 848.3764433141636, 904.1004200820194, 905.0180554098811, 905.7690288976302, 906.3927168796922, 906.9319801014917, 895.2211575928918, 901.202435844276, 902.1429641840245, 902.3818684201277, 902.6750369866843, 663.4659099424961, 665.4776000839366, 665.5840099937539, 665.9833504162386, 666.2704338749062, 14500.854991450056, 14533.491327803476, 14778.852211477855, 14796.556103316918, 14822.332995015251, 14334.49829255971, 14429.969706361677, 14444.711105777826, 14466.0, 14551.78172327416, 11558.0, 11866.940665296705, 11948.103892208119, 11985.58050468238, 11989.002749312673, 3705.40713485841, 3751.6998640108727, 3778.9622103778884, 3822.140018495816, 3915.530136383624, 122901.77098229082, 124822.0, 125246.0, 125325.0, 125991.11013334808, 9496.002919693332, 10757.46212689378, 10808.297460665031, 10833.404162771123, 10839.861814509362, 22250.666240006412, 22461.876906154626, 22615.54768904613, 22680.65979010316, 23089.884550577477, 7825.256600622932, 7852.960735196401, 7875.133735289113, 7892.842143157105, 7921.841563168704, 4214.536400995888, 4250.617444430016, 4304.849330273425, 4315.805788739514, 4463.263561512379, 3282.7373810095137, 3372.15696075981, 3383.780054296512, 3388.762786604914, 3397.4564069749217, 542.888707814897, 551.170488414941, 555.3474667265947, 569.9088145896636, 612.10326871134, 455.55583306276776, 465.60191036663844, 555.1727925391139, 561.2815596037079, 611.8317462697794, 7497.775066748006, 8307.83384332322, 9063.954680226556, 9411.0, 9757.365771224848, 464.4937018649688, 496.81121173953665, 546.7621584610707, 608.4979891589456, 643.7939859244997, 3698.4267438547067, 4347.3044312910415, 4566.611837993742, 4613.469451013109, 4643.512431194744, 91520.0, 106839.0, 121303.0, 145839.0, 148868.0, 129165.35417322854, 132354.33822831017, 133391.0, 133994.0, 135238.0, 112424.0, 114537.0, 114557.0, 114801.99999999833, 116945.0, 8820.338474614558, 8824.382293239412, 8832.867506987272, 8914.86627700572, 9102.635894564144, 52310.215346769066, 55738.32785016456, 58008.12987805102, 62018.68990655018, 62391.0, 92531.07468925494, 96080.03919960711, 96107.0, 97690.0, 99534.00465995538, 11441.989962992713, 11468.31190128595, 11605.129615278718, 11636.41817909118, 11668.824967625662, 12277.693057673272, 12421.813672794735, 12605.747885042065, 12651.87348126507, 13050.934745326213, 11821.586244481401, 11940.761184776082, 11986.460609272777, 11996.76006479883, 12001.0, 11586.362750048827, 11942.582009629621, 12071.517139314328, 12130.029597632345, 12144.939275303566, 11909.40452977365, 11946.462409191781, 11984.460699268728, 12311.75376492483, 12356.567520136752, 10117.140043096419, 10222.0, 10279.537420815932, 10380.377177369382, 10503.028759482186, 8719.084496127814, 9967.900320996698, 10323.48382580853, 10337.069663729999, 10381.402396475225], "value": 7510.09310480165, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1613.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 119.0, 115.0, 118.0, 119.0, 118.0, 118.0, 120.0, 136.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 132.0, 173.0, 97.0, 155.0, 162.0, 139.0, 179.0, 114.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 247.0, 272.0, 274.0, 215.0, 202.0, 196.0, 202.0, 195.0, 200.0], "value": 220.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 75.0, 150.0, 60.0, 68.0, 80.0, 85.0, 164.0, 84.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 120.0, 72.0, 69.0, 82.0, 125.0, 102.0, 105.0, 146.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 90.0, 93.0, 88.0, 93.0, 89.0, 94.0, 93.0, 136.0, 132.0], "value": 100.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 103.0, 102.0, 103.0, 102.0, 102.0, 132.0, 131.0, 103.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 90.0, 90.0, 95.0, 92.0, 89.0, 95.0, 91.0, 132.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 58.0, 60.0, 58.0, 67.0, 72.0, 79.0, 82.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 71.0, 82.0, 75.0, 74.0, 70.0, 69.0, 67.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 88.0, 89.0, 88.0, 98.0, 77.0, 90.0, 77.0, 91.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 135.0, 154.0, 139.0, 164.0, 157.0, 158.0, 135.0, 175.0, 168.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 217.0, 226.0, 192.0, 176.0, 151.0, 224.0, 176.0, 188.0, 175.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 68.0, 91.0, 67.0, 68.0, 72.0, 67.0, 62.0, 76.0], "value": 71.2, "unit": "score"}]}]} 10:21:35 INFO - Return code: 0 10:21:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:35 ERROR - # TBPL SUCCESS # 10:21:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:21:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:21:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:21:35 INFO - 2016-08-26 10:21:35.482 screenresolution[1665:10417] starting screenresolution argv=screenresolution get 10:21:35 INFO - 2016-08-26 10:21:35.484 screenresolution[1665:10417] Display 0: 1600x1200x32@60 10:21:35 INFO - 2016-08-26 10:21:35.490 screenresolution[1666:10420] starting screenresolution argv=screenresolution list 10:21:35 INFO - Available Modes on Display 0 10:21:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:21:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:21:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:21:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:21:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:21:35 INFO - Intel Iris: 10:21:35 INFO - Chipset Model: Intel Iris 10:21:35 INFO - Type: GPU 10:21:35 INFO - Bus: Built-In 10:21:35 INFO - VRAM (Dynamic, Max): 1536 MB 10:21:35 INFO - Vendor: Intel (0x8086) 10:21:35 INFO - Device ID: 0x0a2e 10:21:35 INFO - Revision ID: 0x0009 10:21:35 INFO - Displays: 10:21:35 INFO - Display: 10:21:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:21:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:21:35 INFO - Display Serial Number: 1600x1200 60 10:21:35 INFO - Main Display: Yes 10:21:35 INFO - Mirror: Off 10:21:35 INFO - Online: Yes 10:21:35 INFO - Rotation: Supported 10:21:35 INFO - Return code: 0 10:21:35 INFO - Running post-action listener: _resource_record_post_action 10:21:35 INFO - [mozharness: 2016-08-26 17:21:35.725294Z] Finished run-tests step (success) 10:21:35 INFO - Running post-run listener: _resource_record_post_run 10:21:35 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38183936; Write bytes: 706467328; Read time: 377; Write time: 1878 10:21:35 INFO - TinderboxPrint: CPU usage
54.4% 10:21:35 INFO - TinderboxPrint: I/O read bytes / time
38,183,936 / 377 10:21:35 INFO - TinderboxPrint: I/O write bytes / time
706,467,328 / 1,878 10:21:35 INFO - TinderboxPrint: CPU idle
2,208.2 (45.6%) 10:21:35 INFO - TinderboxPrint: CPU system
978.2 (20.2%) 10:21:35 INFO - TinderboxPrint: CPU user
1,659.3 (34.2%) 10:21:35 INFO - TinderboxPrint: Swap in / out
444,010,496 / 0 10:21:35 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403911168; Write bytes: 393467904; Read time: 30630; Write time: 738 10:21:35 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30940160; Write bytes: 296357376; Read time: 289; Write time: 1097 10:21:36 INFO - Running post-run listener: _upload_blobber_files 10:21:36 INFO - Blob upload gear active. 10:21:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:36 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:37 INFO - (blobuploader) - INFO - Done attempting. 10:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:39 INFO - (blobuploader) - INFO - Done attempting. 10:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:41 INFO - (blobuploader) - INFO - Done attempting. 10:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:41 INFO - Return code: 0 10:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b87d95447efa3c8b2fd738c9432bcbf8b5e75034b42871c1e782561e1ff6242e0f33f5e768c1cf84eb08490ac8adb5e154f949721fc39bf9f902c92238aeab94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/529edf8f24710c3cf84fe1a2d6e97575be29fb0190e9586f1f716e7d139905c72eab2ccb227f34c6069f07ad8692af53fc246c0f4589fe47d538212d34be4245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ec65ade78f2535c02e517941b96d3a0f75beece6f9ac4fe2c5625400710acad5665e7c78d455edfa1d7fdcae15013aac3c19b42aff29ff29d92d56cf1da3bca"} 10:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:41 INFO - Contents: 10:21:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b87d95447efa3c8b2fd738c9432bcbf8b5e75034b42871c1e782561e1ff6242e0f33f5e768c1cf84eb08490ac8adb5e154f949721fc39bf9f902c92238aeab94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/529edf8f24710c3cf84fe1a2d6e97575be29fb0190e9586f1f716e7d139905c72eab2ccb227f34c6069f07ad8692af53fc246c0f4589fe47d538212d34be4245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ec65ade78f2535c02e517941b96d3a0f75beece6f9ac4fe2c5625400710acad5665e7c78d455edfa1d7fdcae15013aac3c19b42aff29ff29d92d56cf1da3bca"} 10:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:41 INFO - Copying logs to upload dir... 10:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.120263 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-26 10:21:41.640027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 10:21:41.643350) ========= 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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b87d95447efa3c8b2fd738c9432bcbf8b5e75034b42871c1e782561e1ff6242e0f33f5e768c1cf84eb08490ac8adb5e154f949721fc39bf9f902c92238aeab94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/529edf8f24710c3cf84fe1a2d6e97575be29fb0190e9586f1f716e7d139905c72eab2ccb227f34c6069f07ad8692af53fc246c0f4589fe47d538212d34be4245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ec65ade78f2535c02e517941b96d3a0f75beece6f9ac4fe2c5625400710acad5665e7c78d455edfa1d7fdcae15013aac3c19b42aff29ff29d92d56cf1da3bca"} build_url:https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/R5fI_kMySYWALp14KVPJ-Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b87d95447efa3c8b2fd738c9432bcbf8b5e75034b42871c1e782561e1ff6242e0f33f5e768c1cf84eb08490ac8adb5e154f949721fc39bf9f902c92238aeab94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/529edf8f24710c3cf84fe1a2d6e97575be29fb0190e9586f1f716e7d139905c72eab2ccb227f34c6069f07ad8692af53fc246c0f4589fe47d538212d34be4245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0ec65ade78f2535c02e517941b96d3a0f75beece6f9ac4fe2c5625400710acad5665e7c78d455edfa1d7fdcae15013aac3c19b42aff29ff29d92d56cf1da3bca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 10:21:41.677233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:21:41.677569) ========= 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.tyOMWJOJNw/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.G2ifIAEXuU/Listeners TMPDIR=/var/folders/f6/kjqp0l7n7cb307nv1hq0lrf400000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 10:21:41.725810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 10:21:41.726143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 10:21:41.726519) ========= ========= Total master_lag: 0.17 =========