builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0162 starttime: 1471373581.6 results: success (0) buildid: 20160816091017 builduid: 366b7a4e0c0a40c2b9e1440e546cdc97 revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.599866) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.600272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.600569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.628440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.628751) ========= 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.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-16 11:53:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.7M=0s 2016-08-16 11:53:01 (28.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.766268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.766601) ========= 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.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.028424 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:01.816606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 11:53:01.816953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-16 11:53:01,894 truncating revision to first 12 chars 2016-08-16 11:53:01,894 Setting DEBUG logging. 2016-08-16 11:53:01,894 attempt 1/10 2016-08-16 11:53:01,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af4cc6c04573?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 11:53:02,669 unpacking tar archive at: fx-team-af4cc6c04573/testing/mozharness/ program finished with exit code 0 elapsedTime=1.029466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 11:53:02.868790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:02.869160) ========= script_repo_revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:02.869631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:02.869946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 11:53:02.889467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-16 11:53:02.890193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:03 INFO - MultiFileLogger online at 20160816 11:53:03 in /builds/slave/test 11:53:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:53:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:03 INFO - {'append_to_log': False, 11:53:03 INFO - 'base_work_dir': '/builds/slave/test', 11:53:03 INFO - 'blob_upload_branch': 'Fx-Team', 11:53:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:03 INFO - 'branch': 'Fx-Team', 11:53:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:03 INFO - 'config_files': ('talos/mac_config.py',), 11:53:03 INFO - 'default_actions': ('clobber', 11:53:03 INFO - 'read-buildbot-config', 11:53:03 INFO - 'download-and-extract', 11:53:03 INFO - 'populate-webroot', 11:53:03 INFO - 'create-virtualenv', 11:53:03 INFO - 'install', 11:53:03 INFO - 'run-tests'), 11:53:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:03 INFO - 'download_minidump_stackwalk': True, 11:53:03 INFO - 'download_symbols': 'ondemand', 11:53:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:03 INFO - 'installer_path': 'installer.exe', 11:53:03 INFO - 'log_level': 'info', 11:53:03 INFO - 'log_name': 'talos', 11:53:03 INFO - 'log_to_console': True, 11:53:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:53:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:53:03 INFO - 'opt_config_files': (), 11:53:03 INFO - 'pip_index': False, 11:53:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:53:03 INFO - 'cmd': ('bash', 11:53:03 INFO - '-c', 11:53:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:53:03 INFO - 'enabled': True, 11:53:03 INFO - 'halt_on_failure': False, 11:53:03 INFO - 'name': 'check_screen_resolution'},), 11:53:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:53:03 INFO - 'cmd': ('bash', 11:53:03 INFO - '-c', 11:53:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:53:03 INFO - 'enabled': True, 11:53:03 INFO - 'halt_on_failure': False, 11:53:03 INFO - 'name': 'check_screen_resolution'},), 11:53:03 INFO - 'run_cmd_checks_enabled': True, 11:53:03 INFO - 'sps_profile': False, 11:53:03 INFO - 'sps_profile_interval': 0, 11:53:03 INFO - 'suite': 'dromaeojs-e10s', 11:53:03 INFO - 'system_bits': '32', 11:53:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:03 INFO - 'title': 't-yosemite-r7-0162', 11:53:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:03 INFO - 'use_talos_json': True, 11:53:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:03 INFO - 'work_dir': 'build'} 11:53:03 INFO - [mozharness: 2016-08-16 18:53:03.111550Z] Running clobber step. 11:53:03 INFO - Running pre-action listener: _resource_record_pre_action 11:53:03 INFO - Running main action method: clobber 11:53:03 INFO - rmtree: /builds/slave/test/build 11:53:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:05 INFO - Running post-action listener: _resource_record_post_action 11:53:05 INFO - [mozharness: 2016-08-16 18:53:05.479580Z] Finished clobber step (success) 11:53:05 INFO - [mozharness: 2016-08-16 18:53:05.479711Z] Running read-buildbot-config step. 11:53:05 INFO - Running pre-action listener: _resource_record_pre_action 11:53:05 INFO - Running main action method: read_buildbot_config 11:53:05 INFO - Using buildbot properties: 11:53:05 INFO - { 11:53:05 INFO - "project": "", 11:53:05 INFO - "product": "firefox", 11:53:05 INFO - "script_repo_revision": "production", 11:53:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:53:05 INFO - "repository": "", 11:53:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:53:05 INFO - "buildid": "20160816091017", 11:53:05 INFO - "pgo_build": "False", 11:53:05 INFO - "basedir": "/builds/slave/test", 11:53:05 INFO - "buildnumber": 89, 11:53:05 INFO - "slavename": "t-yosemite-r7-0162", 11:53:05 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 11:53:05 INFO - "platform": "yosemite_r7", 11:53:05 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 11:53:05 INFO - "branch": "fx-team", 11:53:05 INFO - "repo_path": "integration/fx-team", 11:53:05 INFO - "revision": "af4cc6c04573fca495450725de702f7188dab6ea", 11:53:05 INFO - "stage_platform": "macosx64", 11:53:05 INFO - "builduid": "366b7a4e0c0a40c2b9e1440e546cdc97", 11:53:05 INFO - "slavebuilddir": "test" 11:53:05 INFO - } 11:53:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:53:05 INFO - Running post-action listener: _resource_record_post_action 11:53:05 INFO - [mozharness: 2016-08-16 18:53:05.484471Z] Finished read-buildbot-config step (success) 11:53:05 INFO - [mozharness: 2016-08-16 18:53:05.484621Z] Running download-and-extract step. 11:53:05 INFO - Running pre-action listener: _resource_record_pre_action 11:53:05 INFO - Running main action method: download_and_extract 11:53:05 INFO - mkdir: /builds/slave/test/build/tests 11:53:05 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')]} 11:53:05 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:53:05 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:06 INFO - Downloaded 1199 bytes. 11:53:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:53:06 INFO - Using the following test package requirements: 11:53:06 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:53:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:53:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:53:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'jsshell-mac.zip'], 11:53:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:53:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:53:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:53:06 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:53:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:53:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:53:06 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:53:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:06 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:53:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:07 INFO - Downloaded 16332066 bytes. 11:53:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:53:14 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 11:53:14 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')]} 11:53:14 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:53:14 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:15 INFO - Downloaded 16332066 bytes. 11:53:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:53:21 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')]} 11:53:21 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:53:21 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:23 INFO - Downloaded 14413719 bytes. 11:53:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:53: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')]} 11:53:23 INFO - trying https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:53:23 INFO - Downloading https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/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 11:53:26 INFO - Downloaded 111108485 bytes. 11:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:53:26 INFO - mkdir: /builds/slave/test/properties 11:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:26 INFO - Contents: 11:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:53:27 INFO - Running post-action listener: _resource_record_post_action 11:53:27 INFO - Running post-action listener: set_extra_try_arguments 11:53:27 INFO - [mozharness: 2016-08-16 18:53:27.173184Z] Finished download-and-extract step (success) 11:53:27 INFO - [mozharness: 2016-08-16 18:53:27.173311Z] Running populate-webroot step. 11:53:27 INFO - Running pre-action listener: _resource_record_pre_action 11:53:27 INFO - Running main action method: populate_webroot 11:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:27 INFO - '--tppagecycles', 11:53:27 INFO - '7'], 11:53:27 INFO - 'tests': ['tsvgm']}}, 11:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['damp', 'tps']}, 11:53:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'tests': ['damp', 'tps']}, 11:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['dromaeo_dom']}, 11:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['basic_compositor_video']}, 11:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['a11yr', 11:53:27 INFO - 'ts_paint', 11:53:27 INFO - 'tpaint', 11:53:27 INFO - 'sessionrestore', 11:53:27 INFO - 'sessionrestore_no_auto_restore', 11:53:27 INFO - 'tabpaint']}, 11:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['tsvgx', 11:53:27 INFO - 'tsvgr_opacity', 11:53:27 INFO - 'tart', 11:53:27 INFO - 'tscrollx', 11:53:27 INFO - 'cart']}, 11:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:27 INFO - 'tsvgr_opacity', 11:53:27 INFO - 'tart', 11:53:27 INFO - 'tscrollx', 11:53:27 INFO - 'cart']}, 11:53:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'talos_options': ['--disable-e10s'], 11:53:27 INFO - 'tests': ['tp5o']}, 11:53:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'tests': ['tp5o']}, 11:53:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'talos_options': ['--disable-e10s', 11:53:27 INFO - '--xperf_path', 11:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:27 INFO - 'tests': ['tp5n']}, 11:53:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:27 INFO - 'talos_options': ['--xperf_path', 11:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:27 INFO - 'tests': ['tp5n']}}, 11:53:27 INFO - 'talos.zip': {'path': '', 11:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:27 INFO - Running post-action listener: _resource_record_post_action 11:53:27 INFO - [mozharness: 2016-08-16 18:53:27.191858Z] Finished populate-webroot step (success) 11:53:27 INFO - [mozharness: 2016-08-16 18:53:27.191989Z] Running create-virtualenv step. 11:53:27 INFO - Running pre-action listener: _resource_record_pre_action 11:53:27 INFO - Running main action method: create_virtualenv 11:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:27 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 11:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:27 INFO - Using real prefix '/tools/python27' 11:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:30 INFO - Installing pip.................done. 11:53:30 INFO - Return code: 0 11:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:30 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')]} 11:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:30 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')]} 11:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:30 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:30 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 11:53:30 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 11:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:30 INFO - 'HOME': '/Users/cltbld', 11:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:30 INFO - 'LOGNAME': 'cltbld', 11:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:30 INFO - 'MOZ_NO_REMOTE': '1', 11:53:30 INFO - 'NO_EM_RESTART': '1', 11:53:30 INFO - 'PAGER': '/bin/cat', 11:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:30 INFO - 'PWD': '/builds/slave/test', 11:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:30 INFO - 'SHELL': '/bin/bash', 11:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:30 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:30 INFO - 'USER': 'cltbld', 11:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:30 INFO - 'XPC_FLAGS': '0x0', 11:53:30 INFO - 'XPC_SERVICE_NAME': '0', 11:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:31 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 11:53:31 INFO - Cleaning up... 11:53:31 INFO - Return code: 0 11:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:31 INFO - 'HOME': '/Users/cltbld', 11:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:31 INFO - 'LOGNAME': 'cltbld', 11:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:31 INFO - 'MOZ_NO_REMOTE': '1', 11:53:31 INFO - 'NO_EM_RESTART': '1', 11:53:31 INFO - 'PAGER': '/bin/cat', 11:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:31 INFO - 'PWD': '/builds/slave/test', 11:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:31 INFO - 'SHELL': '/bin/bash', 11:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:31 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:31 INFO - 'USER': 'cltbld', 11:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:31 INFO - 'XPC_FLAGS': '0x0', 11:53:31 INFO - 'XPC_SERVICE_NAME': '0', 11:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:31 INFO - Downloading/unpacking psutil>=3.1.1 11:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:34 INFO - Installing collected packages: psutil 11:53:34 INFO - Running setup.py install for psutil 11:53:34 INFO - building 'psutil._psutil_osx' extension 11:53:34 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 11:53:35 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 11:53:35 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 11:53:35 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 11:53:35 INFO - building 'psutil._psutil_posix' extension 11:53:35 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 11:53:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:53:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:53:35 INFO - ^ 11:53:35 INFO - 1 warning generated. 11:53:35 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 11:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:35 INFO - Successfully installed psutil 11:53:35 INFO - Cleaning up... 11:53:36 INFO - Return code: 0 11:53:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:53:36 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')]} 11:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:36 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')]} 11:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:36 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:36 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 11:53:36 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 11:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:36 INFO - 'HOME': '/Users/cltbld', 11:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:36 INFO - 'LOGNAME': 'cltbld', 11:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:36 INFO - 'MOZ_NO_REMOTE': '1', 11:53:36 INFO - 'NO_EM_RESTART': '1', 11:53:36 INFO - 'PAGER': '/bin/cat', 11:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:36 INFO - 'PWD': '/builds/slave/test', 11:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:36 INFO - 'SHELL': '/bin/bash', 11:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:36 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:36 INFO - 'USER': 'cltbld', 11:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:36 INFO - 'XPC_FLAGS': '0x0', 11:53:36 INFO - 'XPC_SERVICE_NAME': '0', 11:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:53:38 INFO - Installing collected packages: mozsystemmonitor 11:53:38 INFO - Running setup.py install for mozsystemmonitor 11:53:38 INFO - Successfully installed mozsystemmonitor 11:53:38 INFO - Cleaning up... 11:53:39 INFO - Return code: 0 11:53:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:39 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:39 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 11:53:39 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 11:53:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:39 INFO - 'HOME': '/Users/cltbld', 11:53:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:39 INFO - 'LOGNAME': 'cltbld', 11:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:39 INFO - 'MOZ_NO_REMOTE': '1', 11:53:39 INFO - 'NO_EM_RESTART': '1', 11:53:39 INFO - 'PAGER': '/bin/cat', 11:53:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:39 INFO - 'PWD': '/builds/slave/test', 11:53:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:39 INFO - 'SHELL': '/bin/bash', 11:53:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:39 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:39 INFO - 'USER': 'cltbld', 11:53:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:39 INFO - 'XPC_FLAGS': '0x0', 11:53:39 INFO - 'XPC_SERVICE_NAME': '0', 11:53:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:39 INFO - Downloading/unpacking jsonschema==2.5.1 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:39 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 11:53:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:53:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:42 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 11:53:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:53:43 INFO - warning: no files found matching '*.txt' 11:53:43 INFO - no previously-included directories found matching 'build' 11:53:43 INFO - no previously-included directories found matching 'dist' 11:53:43 INFO - no previously-included directories found matching '.git*' 11:53:43 INFO - Installing collected packages: jsonschema, functools32 11:53:43 INFO - Running setup.py install for functools32 11:53:43 INFO - warning: no files found matching '*.txt' 11:53:43 INFO - no previously-included directories found matching 'build' 11:53:43 INFO - no previously-included directories found matching 'dist' 11:53:43 INFO - no previously-included directories found matching '.git*' 11:53:43 INFO - Successfully installed jsonschema functools32 11:53:43 INFO - Cleaning up... 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:43 INFO - 'HOME': '/Users/cltbld', 11:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PAGER': '/bin/cat', 11:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:43 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - 'XPC_FLAGS': '0x0', 11:53:43 INFO - 'XPC_SERVICE_NAME': '0', 11:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:53:43 INFO - Cleaning up... 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:53:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:43 INFO - 'HOME': '/Users/cltbld', 11:53:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PAGER': '/bin/cat', 11:53:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:43 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - 'XPC_FLAGS': '0x0', 11:53:43 INFO - 'XPC_SERVICE_NAME': '0', 11:53:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:46 INFO - Downloading blobuploader-1.2.4.tar.gz 11:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:53:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:53:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:47 INFO - Downloading docopt-0.6.1.tar.gz 11:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:53:47 INFO - Installing collected packages: blobuploader, requests, docopt 11:53:47 INFO - Running setup.py install for blobuploader 11:53:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:53:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:53:47 INFO - Running setup.py install for requests 11:53:48 INFO - Running setup.py install for docopt 11:53:48 INFO - Successfully installed blobuploader requests docopt 11:53:48 INFO - Cleaning up... 11:53:48 INFO - Return code: 0 11:53:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:48 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:48 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 11:53:48 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 11:53:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:48 INFO - 'HOME': '/Users/cltbld', 11:53:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:48 INFO - 'LOGNAME': 'cltbld', 11:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:48 INFO - 'MOZ_NO_REMOTE': '1', 11:53:48 INFO - 'NO_EM_RESTART': '1', 11:53:48 INFO - 'PAGER': '/bin/cat', 11:53:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:48 INFO - 'PWD': '/builds/slave/test', 11:53:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:48 INFO - 'SHELL': '/bin/bash', 11:53:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:48 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:48 INFO - 'USER': 'cltbld', 11:53:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:48 INFO - 'XPC_FLAGS': '0x0', 11:53:48 INFO - 'XPC_SERVICE_NAME': '0', 11:53:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:48 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ozUgQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-t89weD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-tcxF1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Wwe5WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0sVxQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-frsVhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-LqrmE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0bzQ_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-UO5sAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:49 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7Dt5Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9euFD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-fRbKz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YD8YsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BAvNXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ku9v7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-bWH7w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:50 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-fiZlgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:53:50 INFO - Running setup.py install for manifestparser 11:53:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:53:50 INFO - Running setup.py install for mozcrash 11:53:51 INFO - Running setup.py install for mozdebug 11:53:51 INFO - Running setup.py install for mozdevice 11:53:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Running setup.py install for mozfile 11:53:51 INFO - Running setup.py install for mozhttpd 11:53:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Running setup.py install for mozinfo 11:53:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Running setup.py install for mozInstall 11:53:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:53:51 INFO - Running setup.py install for mozleak 11:53:52 INFO - Running setup.py install for mozlog 11:53:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Running setup.py install for moznetwork 11:53:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Running setup.py install for mozprocess 11:53:52 INFO - Running setup.py install for mozprofile 11:53:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Running setup.py install for mozrunner 11:53:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:53:52 INFO - Running setup.py install for mozscreenshot 11:53:53 INFO - Running setup.py install for moztest 11:53:53 INFO - Running setup.py install for mozversion 11:53:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:53 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')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 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')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:53 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 11:53:53 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 11:53:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:53 INFO - 'HOME': '/Users/cltbld', 11:53:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PAGER': '/bin/cat', 11:53:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:53 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - 'XPC_FLAGS': '0x0', 11:53:53 INFO - 'XPC_SERVICE_NAME': '0', 11:53:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Qxc_B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:53 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)) 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-kWEiBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:53 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)) 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7OwAQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:53 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)) 11:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:53 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-vxBVO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-F5ktYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-txjtZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Mvh8yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Lg85dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-vAeLZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-IR7lhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-lNwMSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MJFDrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:54 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)) 11:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:54 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-N32xMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8Mb8Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-qX8lMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XGv558-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:55 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)) 11:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:55 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-O3S305-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:55 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)) 11:53:55 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)) 11:53:55 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)) 11:53:55 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)) 11:53:55 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)) 11:53:55 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)) 11:53:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:53:55 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 11:53:55 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 11:53:55 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 11:53:55 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 11:53:55 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 11:53:55 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 11:53:57 INFO - Downloading blessings-1.6.tar.gz 11:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:53:58 INFO - Installing collected packages: blessings 11:53:58 INFO - Running setup.py install for blessings 11:53:58 INFO - Successfully installed blessings 11:53:58 INFO - Cleaning up... 11:53:58 INFO - Return code: 0 11:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:58 INFO - Reading from file tmpfile_stdout 11:53:58 INFO - Current package versions: 11:53:58 INFO - blessings == 1.6 11:53:58 INFO - blobuploader == 1.2.4 11:53:58 INFO - docopt == 0.6.1 11:53:58 INFO - functools32 == 3.2.3-2 11:53:58 INFO - jsonschema == 2.5.1 11:53:58 INFO - manifestparser == 1.1 11:53:58 INFO - mozInstall == 1.12 11:53:58 INFO - mozcrash == 0.17 11:53:58 INFO - mozdebug == 0.1 11:53:58 INFO - mozdevice == 0.48 11:53:58 INFO - mozfile == 1.2 11:53:58 INFO - mozhttpd == 0.7 11:53:58 INFO - mozinfo == 0.9 11:53:58 INFO - mozleak == 0.1 11:53:58 INFO - mozlog == 3.3 11:53:58 INFO - moznetwork == 0.27 11:53:58 INFO - mozprocess == 0.23 11:53:58 INFO - mozprofile == 0.28 11:53:58 INFO - mozrunner == 6.12 11:53:58 INFO - mozscreenshot == 0.1 11:53:58 INFO - mozsystemmonitor == 0.3 11:53:58 INFO - moztest == 0.7 11:53:58 INFO - mozversion == 1.4 11:53:58 INFO - psutil == 3.1.1 11:53:58 INFO - requests == 1.2.3 11:53:58 INFO - wsgiref == 0.1.2 11:53:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:58 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:58 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 11:53:58 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 11:53:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:58 INFO - 'HOME': '/Users/cltbld', 11:53:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:58 INFO - 'LOGNAME': 'cltbld', 11:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:58 INFO - 'MOZ_NO_REMOTE': '1', 11:53:58 INFO - 'NO_EM_RESTART': '1', 11:53:58 INFO - 'PAGER': '/bin/cat', 11:53:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:58 INFO - 'PWD': '/builds/slave/test', 11:53:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:58 INFO - 'SHELL': '/bin/bash', 11:53:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:58 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:58 INFO - 'USER': 'cltbld', 11:53:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:58 INFO - 'XPC_FLAGS': '0x0', 11:53:58 INFO - 'XPC_SERVICE_NAME': '0', 11:53:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 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)) 11:53:59 INFO - Cleaning up... 11:53:59 INFO - Return code: 0 11:53:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 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 0x10dc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe62849cf10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, '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.NPI7LgyN9W/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.eYV49BAXeO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:53:59 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 11:53:59 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 11:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:59 INFO - 'HOME': '/Users/cltbld', 11:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:59 INFO - 'LOGNAME': 'cltbld', 11:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:59 INFO - 'MOZ_NO_REMOTE': '1', 11:53:59 INFO - 'NO_EM_RESTART': '1', 11:53:59 INFO - 'PAGER': '/bin/cat', 11:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:59 INFO - 'PWD': '/builds/slave/test', 11:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:59 INFO - 'SHELL': '/bin/bash', 11:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:53:59 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:59 INFO - 'USER': 'cltbld', 11:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:59 INFO - 'XPC_FLAGS': '0x0', 11:53:59 INFO - 'XPC_SERVICE_NAME': '0', 11:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:53:59 INFO - Cleaning up... 11:53:59 INFO - Return code: 0 11:53:59 INFO - Running post-action listener: _resource_record_post_action 11:53:59 INFO - Running post-action listener: _start_resource_monitoring 11:53:59 INFO - Starting resource monitoring. 11:53:59 INFO - [mozharness: 2016-08-16 18:53:59.528712Z] Finished create-virtualenv step (success) 11:53:59 INFO - [mozharness: 2016-08-16 18:53:59.529649Z] Running install step. 11:53:59 INFO - Running pre-action listener: _resource_record_pre_action 11:53:59 INFO - Running main action method: install 11:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:59 INFO - Reading from file tmpfile_stdout 11:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:53:59 INFO - Reading from file tmpfile_stdout 11:53:59 INFO - Output received: 11:53:59 INFO - Usage: mozinstall [options] installer 11:53:59 INFO - Options: 11:53:59 INFO - -h, --help show this help message and exit 11:53:59 INFO - -d DEST, --destination=DEST 11:53:59 INFO - Directory to install application into. [default: 11:53:59 INFO - "/builds/slave/test"] 11:53:59 INFO - --app=APP Application being installed. [default: firefox] 11:53:59 INFO - mkdir: /builds/slave/test/build/application 11:53:59 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'] 11:53:59 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 11:54:33 INFO - Reading from file tmpfile_stdout 11:54:33 INFO - Output received: 11:54:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:54:33 INFO - Running post-action listener: _resource_record_post_action 11:54:33 INFO - [mozharness: 2016-08-16 18:54:33.785094Z] Finished install step (success) 11:54:33 INFO - [mozharness: 2016-08-16 18:54:33.785228Z] Running run-tests step. 11:54:33 INFO - Running pre-action listener: _resource_record_pre_action 11:54:33 INFO - Running main action method: run_tests 11:54:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:54:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:54:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:54:33 INFO - 2016-08-16 11:54:33.799 screenresolution[1630:7545] starting screenresolution argv=screenresolution get 11:54:33 INFO - 2016-08-16 11:54:33.802 screenresolution[1630:7545] Display 0: 1600x1200x32@60 11:54:33 INFO - 2016-08-16 11:54:33.807 screenresolution[1631:7547] starting screenresolution argv=screenresolution list 11:54:33 INFO - Available Modes on Display 0 11:54:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:54:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:54:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:54:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:54:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:54:34 INFO - Intel Iris: 11:54:34 INFO - Chipset Model: Intel Iris 11:54:34 INFO - Type: GPU 11:54:34 INFO - Bus: Built-In 11:54:34 INFO - VRAM (Dynamic, Max): 1536 MB 11:54:34 INFO - Vendor: Intel (0x8086) 11:54:34 INFO - Device ID: 0x0a2e 11:54:34 INFO - Revision ID: 0x0009 11:54:34 INFO - Displays: 11:54:34 INFO - Display: 11:54:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:54:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:54:34 INFO - Display Serial Number: 1600x1200 60 11:54:34 INFO - Main Display: Yes 11:54:34 INFO - Mirror: Off 11:54:34 INFO - Online: Yes 11:54:34 INFO - Rotation: Supported 11:54:34 INFO - Return code: 0 11:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:34 INFO - Python 2.7.3 11:54:34 INFO - Return code: 0 11:54:34 INFO - grabbing minidump binary from tooltool 11:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:54:34 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 0x10dbc6d30>, '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 0x10d92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dbbeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:34 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 11:54:34 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 11:54:34 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 11:54:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:34 INFO - Return code: 0 11:54:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 11:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NPI7LgyN9W/Render', 11:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:54:34 INFO - 'HOME': '/Users/cltbld', 11:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:54:34 INFO - 'LOGNAME': 'cltbld', 11:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:34 INFO - 'MOZ_NO_REMOTE': '1', 11:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:34 INFO - 'NO_EM_RESTART': '1', 11:54:34 INFO - 'PAGER': '/bin/cat', 11:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:34 INFO - 'PWD': '/builds/slave/test', 11:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:54:34 INFO - 'SHELL': '/bin/bash', 11:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYV49BAXeO/Listeners', 11:54:34 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:54:34 INFO - 'USER': 'cltbld', 11:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:34 INFO - 'XPC_FLAGS': '0x0', 11:54:34 INFO - 'XPC_SERVICE_NAME': '0', 11:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:54:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:54:34 INFO - mozversion application_buildid: 20160816091017 11:54:34 INFO - mozversion application_changeset: af4cc6c04573fca495450725de702f7188dab6ea 11:54:34 INFO - mozversion application_display_name: Nightly 11:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:34 INFO - mozversion application_name: Firefox 11:54:34 INFO - mozversion application_remotingname: firefox 11:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:54:34 INFO - mozversion application_vendor: Mozilla 11:54:34 INFO - mozversion application_version: 51.0a1 11:54:34 INFO - mozversion platform_buildid: 20160816091017 11:54:34 INFO - mozversion platform_changeset: af4cc6c04573fca495450725de702f7188dab6ea 11:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:54:34 INFO - mozversion platform_version: 51.0a1 11:54:34 INFO - using testdate: 1471373674 11:54:34 INFO - actual date: 1471373674 11:54:34 INFO - starting webserver on 'localhost:49275' 11:54:34 INFO - SUITE-START | Running 2 tests 11:54:34 INFO - TEST-START | dromaeo_css 11:54:34 INFO - operating with platform_type : mac_ 11:54:34 INFO - Initialising browser for dromaeo_css test... 11:54:34 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1HJz_Y/profile http://localhost:49275/getInfo.html) 11:54:37 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 11:54:37 INFO - PROCESS | 1641 | colorDepth:24 11:54:37 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 11:54:37 INFO - PROCESS | 1641 | __metrics 11:54:37 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:54:38 INFO - TEST-INFO | 1641: exit 0 11:54:38 INFO - Browser initialized. 11:54:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:38 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1HJz_Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:50 INFO - PROCESS | 1644 | RSS: Main: 239374336 11:54:50 INFO - PROCESS | 1644 | 11:55:39 INFO - PROCESS | 1644 | 1471373739708 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] 11:57:51 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 11:57:53 INFO - PROCESS | 1644 | RSS: Main: 254173184 11:57:53 INFO - PROCESS | 1644 | 12:00:55 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 12:00:56 INFO - PROCESS | 1644 | RSS: Main: 266821632 12:00:56 INFO - PROCESS | 1644 | 12:03:58 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 12:03:58 INFO - PROCESS | 1644 | RSS: Main: 271081472 12:03:58 INFO - PROCESS | 1644 | 12:07:00 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 12:07:01 INFO - PROCESS | 1644 | RSS: Main: 271634432 12:07:01 INFO - PROCESS | 1644 | 12:10:03 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 12:10:04 INFO - PROCESS | 1644 | RSS: Main: 276910080 12:10:04 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 12:13:07 INFO - PROCESS | 1644 | RSS: Main: 279212032 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | __start_tp_report 12:13:07 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 12:13:07 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 12:13:07 INFO - PROCESS | 1644 | |i|pagename|runs| 12:13:07 INFO - PROCESS | 1644 | |0;dojo.html;3172.159377764892;3448.1034930917986;3465.6361082086382;3496.073540511764;3504.614492405835;5768.307803063638;5814.156947242647;5817.243758311419;5862.560307976897;5908.261467316585;5847.44449277319;5862.355140934494;5908.438698323663;5952.2262105926275;5982.371850955641;5124.4875512448825;5184.53339199472;5205.115130427817;5289.973550132244;5299.311089558352;3992.960070399288;4642.675012749109;5312.654677445954;5318.574514038887;5341.786328546854;4787.473377928408;5116.181410974226;5125.718085505296;5153.896922061575;5281.471852814726;5157.149070403379;5165.9225111623355;5215.426303106655;5223.425423203445;5257.658252213594;4035.515738111416;4192;5190.299309593194;5219.347581552306;5226.634135610509;4727.905441891143;5749.281339832521;5810.5932584719085;5864.76540938362;5885.588008839383;5410.594205434569;5878.5297176225795;6221.066839973995;6262.405071518198;6288.182536270301;6269.686515674198;6279.937200627981;6294.874102517924;6304.27500837405;6321.1782468278825;5040.017196646692;5740.540756739492;5857.15071314657;5878.676672782953;5901.911471327933;6318.115463835067;6331.96834015827;6339.175907132043;6351.936480635227;6358.395952384516;6203.844903877349;6221.844453888599;6244.188255526752;6263.342349053284;6265.4361107500545;5153.819616313411;6116.214037636738;6223.657698826518;6241.75032998684;6252.124702541648;6204.627722336674;6230.688465576703;6232;6259.0924315973925;6273.0904018917;6192.349803270682;6221.353296459408;6231.096491008779;6278.937210627835;6281.309056003836;4885;4925.950740492549;4970.329005584272;4985.850424487271;5014.348134742533;4437.001674623184;4493.483249426293;4512.932306015412;4537.546245375502;4546.1135078659345;5868.589198756046;5952.613080149777;5966.433188847052;5980.85047873798;5982.970085149634;6175.938240617536;6194;6250.1874756282305;6252.468540174136;6273.9372606273355;5918.467337939606;5926.67403292823;5957.106434034929;5977.491913187428;5989.760409583655;5500.367457742331;5509.256250406143;5516.979358818631;5519.972400137974;5553.389127196006;6213.96893015532;6309.936900631119;6311.463525600376;6415.06981487691;6438.710258038306;6270.216222972129;6271.153394291895;6277.5605707600025;6312.621242725268;6315.242170939517;6352.269489008823;6388.2972872984865;6421.967890160519;6434.967825160844;6438.7102580384935;6119.654885716854;6203.534734894991;6233.7844120396085;6294.748210071546;6307.716152773228;6199.380061993765;6267.561270711007;6279.811605651837;6282.434580887742;6291.213598300213;6207.162033125651;6251.031090181029;6268.4671802897265;6270.9372906270355;6282.183316168869;6089.421504957022;6116.548817443993;6147.616786223064;6210.7515699373325;6236.875262494816;4939.506049395175;5538.030844602098;6126.387361263838;6145.66198859067;6157.322694503511;6177.62934223948;6211.0372892201785;6232.314445411092;6240.719167637377;6247.625142491465;4999.300097986212;5302.390225124006;5687.9431205687415;6104.755809767737;6110.450059494667 12:13:07 INFO - PROCESS | 1644 | |1;ext.html;477.9498152693967;483.5333902783815;508.74308474220516;509.6890896553103;568.9985625299473;30620.387592248197;33678.15804604886;37320.25359492809;39744.60255397445;39835.00412489689;40800;41253.58746412535;41287;41333.173336533255;41343;9555.761105972371;9749.07383798538;9752.561134748918;9774.853377199348;9778.90221097787;9682;9732.124108830203;9765.609375625001;9787.657431989881;9801;9743.658971935984;9749.976252493492;9777.853332200022;9789.608415663364;9797.412155270671;9694.709158725249;9695.51522423876;9741.31810773246;9751.853722194173;9756.804863902753;9462.101100395452;9484.099010593982;9539;9595.472249026301;9608.039196080406;38988;39348.60651393478;39373;39434.60565394338;39498.60501394978;2648.4835457085874;3302.207470207133;3334.61651910031;3500.6324335944614;3530.6292839252023;28422;28572;29400;29621.555676664866;30542.236444088852;3111.9222019449467;3154.306052668432;3160.5575219469292;3176.4123637127204;3250;439467;445855;446819;446977;448067;33127.83436082804;33185.83407082949;33278.168045798564;33394.83118090855;33399.33201336008;33823.49264761031;34487.4826877597;34616.48075278873;34829.82585087109;34852.128696782784;15914.363425463083;16001;16094.356225750838;16118.597035074217;16129.193540323171;12197.939010304892;12277.570285039981;12325.260484370967;12361.196522226026;12382.947449466896;18752.156152973148;18793;18793.718094228596;18818.623627527373;18969.146388412555;6877.105976223059;7284.599347035964;7756.672998100547;7950.562719050507;8057.31512821405;887.5695287785419;927.6892241099307;971.6502059258661;987.1609132237684;1065.350136416785;26098.608520872203;27526.76129574174;28952.276193095342;29805.10584682463;30238.54642180369;942.4486675294892;949.4255975135083;1052.9417934975454;1096.3969816600838;1101.1851230089676;14857;15514.767278490832;15515.182871015215;15585.142817145166;15648.530544083696;682955;701359;703749;705315;706361;55763.44236557664;56076.71961640166;56093.71953140208;56233.43766562364;56364.71817640885;1345.078621144519;1356.0507644648785;1397.371182967689;1398.189050350794;1398.5175114585452;21992.670109948045;25508.744912551378;27944.580831287953;28757.85621071965;29530.852345738134;40447.1910561793;49213;49460.75269623629;49594.50405495899;49721.502784971686;597457;600437;601928;601970;602213;23021.769782301963;26255.081072162382;26281.948722050904;26499.205023849314;26693.19920402391;46273.76863115663;46626.53373466358;46675.29987050129;47927;48008.5199148018;28051.85974070198;31139.221519462193;38026;38056.858294251215;38638;37968.62031379761;38118.809405952794;38957.41563876601;39171.43314267397;39677.60322396739;32078.877239297446;37546.62453375541;38367;38723.61276387313;39196.60803391929;33083.33833323368;33676;33760.49359259564;34203;34450.310993780484;22147.778522215216;25540.10609628654;25680.472783577683;25813.870930645226;25891.741082589688 12:13:07 INFO - PROCESS | 1644 | |2;jquery.html;346.22272997121456;357.39064894355124;373.7944130728099;386.05994403627153;404.12708549533016;19973.700394494095;20252.39242822716;20859.165633374665;20860;21045.368638940818;11450.48472818723;11924.761504769922;12079.396030198499;12090.395480225976;14932.626684332898;5412.4587541245855;5670.829875103733;5673.092305231164;5676.120201368773;5685.37460879305;3975.741576797499;5170.586353091762;5580.581456390767;6864.450843932498;6911.619860907648;6761.966190169042;6927.3419025192525;6944.51388402812;6946.791596252096;6951.721931122749;5513.5037846594;6825.55633883796;6866.553674011173;6873.828154296132;6912.205096413902;5984.281886173687;6012.6392416455155;6027.7287522061615;6066.726997285133;6102.908456373158;13175.538856140085;13466.865331346658;13501.864981350258;20118.79881201184;25612;2168.8048075673264;2216.091402524973;2218.9556208875892;2319.988400058006;2395.0898658509827;10301.690949271533;10314.690559283234;10329.793404131875;13547.864521354759;13605.31973401326;1899.705545640428;1934.2263094762068;1946.9415917522497;1961.6076784643128;1987.4832543538785;128116.35941820231;131731.68268317386;131943;132285.6771432283;132771;11307.660770176743;11546.711332216593;11707.121965852595;11719.355435450962;11727.882721172678;10919.890801091888;12200.633980980585;14148.43406263738;14381.92135589835;14424.06243594163;8105.6757729691335;8241.546714930617;8253.628586713612;8282.420230583923;8381.832363352698;7338.302861228175;8045.356371490267;8168.305694016075;8175.509469431853;8221.342292616577;4204.579542045833;4215.283401821697;4432.756198409118;4519.457665080211;4609.631229501631;1664.8668106551447;1784.4111443223705;1823.3228846334657;1903.971440428367;1971.7338159348592;794.3168874767695;813.4427916876958;877.6840337478502;906.582971832951;961.6874515782399;16326.346946122023;19771.50571235702;20684.48288792762;20789.584208315748;20903.79096209049;913.8446464101119;927.7495076329353;929.1544694328129;970.9951450242703;1015.5633077776627;8343;10830.916908309106;10930.398828064534;10935;11011.724706882393;236766;237432;237548;491704;599849;133337;134484;135449;135970;136746;750.6246876561719;938.1978408460805;963.5375019990444;971.1162841813915;974.0454354732402;18274.90862545679;18554.44336669902;18623;18705;18757;37628.435573465875;56427;56674.14988775089;57001;57381.71309143428;81676.59161704153;82088;82759.85059395942;82998.17001829905;84694.72957905513;7928.365730741642;8011.479253848481;8013.6794528218215;8201.876971845308;8315.459495132796;9072.274218062672;11080.279781814157;11897.940510297392;12342;13231.66920826987;10873.293235939638;11121.221514493907;11128.610498632834;11231.719207019563;11234.550617975516;10196.898031019595;11046.723831904266;11292.209545331747;11346.773064538498;11459.255148415326;10209.897901020895;11101.278416902875;11412.144089193178;11563.95924366811;11655.358955257543;6525.673716314261;6690.330966903271;7463.514871533333;7664.195259497673;8028.59857007159;8659.437136586102;9587.472689001892;9722.076402741728;10929;11137.99758021782 12:13:07 INFO - PROCESS | 1644 | |3;mootools.html;1480.0601617972588;1498.460554200487;1538.8845836562257;1551.868091212247;1878.6242751449713;7938;8493.065762766098;8636.827263454743;8980.77548061298;9018.278537716984;8642.697505587306;8756.168164024424;8799.384043116985;8808.735737927873;8809.075047120055;2346.1319311854636;2376.0495801679294;2378.2508509819436;2393.234165067179;2396;2321.9071237150492;2356.2460012795914;2368.301351101429;2368.7157541095094;2375.9406014849683;2334.7898689117974;2363.361892289081;2373.620220764678;2375.8336916415856;2380.8809559521956;2334.1480359668767;2347.5187586544716;2357.257463898875;2368.5736567417857;2368.6920700309024;1949.3859434278156;2349.1660460536436;2351.811855051592;2354.0701422938014;2359.5634807560655;7385.29839665231;7526.774196774106;8273.627686754111;8874.112588741074;8912.732618021404;4610.5389461053965;5269.86825329366;5343.65266257692;5447.237386765856;5455.372632147274;3511.262634846685;3624.1483251435893;3678.2643471305846;3688.3729765939856;3693.2059607184583;1076.359566058194;1108.5233349659643;1111.4887151910132;1133.8525991621118;1133.9489722962487;11893;11929.761404771943;11988.760224795542;11990.400479976053;11992.880071199264;4574.336721175411;4704.317873908264;4864.513548645107;4876.268559716071;4883.926741098886;10055.39667619945;10136.037076477724;10154.796904062025;10177.643782467578;10184.949075254724;5347.919781203285;5350.117230656976;5400.702961337164;5410.78356865721;5422.40353561108;4449.354843547668;4794.4486384065585;4906.975465122651;4928.926066109011;4965.056639238605;3855.4987851579117;3908.101136738566;3973.9071755267532;3988.105649816372;4004.3192657248337;1290.0840403313564;1296.1704509114174;1299.2789002103923;1310.3186343101534;1321.4582021371384;866.6360128745941;875.8861348024843;909.4497828813472;913.5751875377981;931.329442801182;4798.4001999750035;5888.735006924699;5906;5955.255593050869;6180.3201647818705;875.8598624220094;907;913.1279627955287;942.3780304998668;958.8945216026232;3726.832292546842;3889.5219816470126;3929.3713005918917;4068.572799856032;4167.541570427251;10714.303570267908;10729.517171727291;10738;10996.450177491093;11068.723281918017;10946.835797463045;11020.228583999204;11028;11045.944770276097;11049.447527623586;6942.583444993316;8181.836363272701;8261.008678958564;8277.089520152898;8400.201980811813;4874.147024270809;5106.95307461962;5331.893362132658;5801.419858014165;6024.90962635552;9297.6280948764;9967.800643987224;10303.690889273334;10314.484275786332;10404.635837745642;10228.181745460197;10325.896741032493;10359.274850760374;10406.427646479517;10411.531481083219;7097.396721278543;7494.887576686463;7572.20491848348;7651.732189373345;7793.766187014398;8597.8710319344;8663.176998185163;8669.653213871374;8677.956610216908;8681.696140635047;7560.470767046474;7631.3131818136635;7655.157932627518;7768.805779855549;7816.257455541714;7408.814779630552;7496.212897645669;7498.475106742694;7539.32146106853;7645.159032506531;7031.824204394931;7095.858082838211;7159.928400715926;7182.102237220348;7186.856262874818;4553.3852929855375;5019.7490125494305;5163.741812909265;5167.715775632376;5183.896322073613;4401.405810215708;5037.798488060436;5124.256982737407;5193.169092945262;5259.7370131494035 12:13:07 INFO - PROCESS | 1644 | |4;prototype.html;298.92377443751855;306.628978935488;313.49996755175493;314.16275625458155;314.3147937496259;4586.770661466926;5291.417944026163;5415.64798288111;5549.250851135095;5594.468525490072;4502.144592527417;4729.196036673765;5348.839534813962;5538.944610553894;5594.580406469521;4057.452243947066;4152.958470415302;4163.271427500175;4184.66522678185;4198.979005104986;3795.7912314822674;4065.308897487434;4172.457580514529;4210.936835947463;4218.219629368561;3997.6402123808853;4014.498187726534;4037.636612704856;4041.454403655513;4101.958980410188;3324.9168770780925;3567.4470457078933;3858.054776579742;3949;4057.4725285712816;3152;3285.8685652573868;3544.1848374873666;3544.4506101554302;3553.626869178751;4740.312654665088;4779.924516983651;5319.5478384337375;5333.146696528537;5363.712708949863;3731.9626803731885;4678.789454474557;4701.600363969067;4716.622670186377;4728.38530990969;4887.535684110004;5042.899142017176;5265.473452654742;5340.279062326614;5829.067349224146;3769.6795772359383;3847.3459511883048;3876.7480113792512;3881.2819628368843;3885.669718073967;5599.832005039855;5752.683602401867;6160.983437732769;6176.0118381059265;6198.543342314552;3311.6357200707903;3526.453399723047;3981.462502562175;3991;4003.559608443069;3768.66212494566;4010.538788039413;4044.3933409988736;4050.797460126982;4052.959470405317;4709;4732.432108147044;4736.834210802605;4770.284457331428;4773.212419950669;4931.753412329369;5922.437368449991;5933.228680271537;5957.6127551709;5980.401959803985;1150.8561429821273;1297.5718013055669;1349.3657980749033;1381.4819442708983;1383.6471699716508;877.4472082588056;889.9599518021705;910.4446287764458;913.5523593439167;914.3782228084966;4572.588467037916;5186.714730689773;5218.930119325529;5404.405515393303;5451.291332126877;5667.376588575254;5976.581639285208;5986.5210783137245;6025.367336429699;6039.4262545058145;5199.714015729096;5233.790648374099;5353.652012619167;5426.375966763794;5433.918491222635;2430.501747141832;2631.7762990146052;2649.417128231786;2671.49241644087;2702.095023008774;4502.3980815347595;4891.461939186686;5027.597792176617;5125.282460455539;5264.894702105937;4091.7954102294766;4749.810007599657;4811.917318603286;5093;5169.71566563835;4431.977840110779;4506.954930450719;4834.854954351375;5274.176222239;5304.2230852664015;4473.731576105444;4723.527647235249;4727.645426593088;4761.952380476151;4887.36464259644;3751.4408466938594;4873.658843880894;4912.729799861042;4982.611823959742;4995.027958364767;4244.87265382039;4453.933191002202;4992.600591952562;5186.922196167136;5218.051800732574;3104.642966058842;3258.4033823426826;3467.878624248139;3477.982610086933;3546.4503002034726;4711.552402521755;4961.603071754179;5059.494050594911;5085.567726743268;5095.140273799962;4469.5530446955045;4859.878503037311;4865.927011094907;4891.706497610155;4958.8760280993265;4292.9608435993905;4436.933445998248;4907.533784290486;4930.580900623487;4958.380202474691;4481.327800829901;4708.741019243975;4786.9655396457065;4794.9280760787915;5122.410922743932;4852.902941941212;5206.927912531624;5856.619319744203;5888.175655408332;5906.26171728534;5092.261622064706;5137.434882163034;5752.088579765799;5759.337676167294;5781.392953739965 12:13:07 INFO - PROCESS | 1644 | |5;yui.html;714.9356557909789;716.2050124361961;762.3215338348871;785.2696991797633;801.1988011988012;15174.468893588726;15888.841111588881;15888.920555397235;15930.840691593081;15933;14311.713765724679;14415.495457658984;14417.78373324401;14438.350274237659;14454.349554270057;665.0523004718282;832.4505826154755;833.912439193885;856.7001549457702;860.9827803443927;852.1010334097525;852.1606217875419;867.371155911965;867.4101610904582;873.0527377795069;917.7430319510547;918.6187732091207;919.6505327975393;920.802027564077;922.2667978956746;887.9644814207423;907.4328544659588;907.8093600343869;909.0545832334365;909.5679552212679;664.3688495928886;675.4022689919408;684.2029036172853;687.9793606191822;688.6900894597451;14778.482753103697;14971.401143954228;14987.100773953598;15040.699186016327;15052.247387630574;14362.210078445682;14656.267186640625;14667.266636668232;14705.558833234913;14744;10591.205659575562;11852.229605075643;11917.284962902168;12020.579279725254;12167.452464639113;3248.6751324867323;3888.1251718363424;3913.571546385577;4047.97976010121;4049.696272779524;112769;112899.30651040158;112968;114997.4250128744;116065.41967290195;9501.42991420517;11100.278481898651;11194.216404851582;11339.489722962486;11442.427878606037;23012.309630711105;23099.3070207894;23245;23354.64968025481;23472.413189670053;7274.090738657668;8093.554854482943;8196.959015204886;8257.42198046131;8280;4246.193223287565;4544.522825103382;4577.656675749332;4637.466691330473;4728.148933191989;3597.172650290448;3709.0541911812315;3725.0873535983314;3730.6642402183934;3869.9226015480094;716.8924661300847;733.8385555177853;740.5482655580092;745.284526854226;745.9738909138155;633.8859005379076;668.2682462703332;681.9659017049128;700.6496751624188;707.3492387003865;8869.778255543533;9310.674126405678;9577.952110239405;9604.38785192993;9644.855327170098;674.8312921769558;678.5521555773265;685.6503183376415;694.298758254167;698.2982102986466;4379.211741886427;4644.883877903079;4656.464506581787;4660.184467718136;4678.134545109166;127773;168472;171027.01405450748;172129.13935430493;177423;80878.78681819777;82626;101155;115006;120133.20285976803;103591.44612830965;105013.37466563244;106368.46815765872;109077.45461272643;111462.44268778604;8448.366372522209;8801.735947921572;9332.16010559053;9939.254555908192;10167.237457190593;58014.279028547026;59425.7028714871;60888.69555652371;62310.442238944386;63334.68332658307;74292.25707742853;94742;95603;96828;97089.51455242679;12452.875471245172;12915.806262906252;13628.93185534066;13722.794158087836;13769.862301376857;14610.853891461375;15085.773713394527;15323.233838307817;15334.846651533342;15732.60668483297;12837.587865334992;13536.864631353561;13872.722545548831;14096.436142554183;14114.929425352808;13967.441302347792;14004.859951400356;14011.649708757363;14100.36548355306;14684.632884177981;13621.659458513617;13717.725645486835;13881.444742210198;14010.229437381042;14112.929435352757;9831.705048848546;10999.505022273857;11243.775124497628;11450.427478626201;11627.244229125079;8909.73270801877;11430.599929002445;11440.885591143982;11619.709507262387;11704.005159561533 12:13:07 INFO - PROCESS | 1644 | __end_tp_report 12:13:07 INFO - PROCESS | 1644 | __start_cc_report 12:13:07 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,417 12:13:07 INFO - PROCESS | 1644 | __end_cc_report 12:13:07 INFO - PROCESS | 1644 | __startTimestamp1471374787713__endTimestamp 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | ------- Summary: start ------- 12:13:07 INFO - PROCESS | 1644 | Number of tests: 6 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5749.56 Median:5989.76 stddev:700.45 (11.7%) stddev-sans-first:672.78 12:13:07 INFO - PROCESS | 1644 | Values: 3172.2 3448.1 3465.6 3496.1 3504.6 5768.3 5814.2 5817.2 5862.6 5908.3 5847.4 5862.4 5908.4 5952.2 5982.4 5124.5 5184.5 5205.1 5290.0 5299.3 3993.0 4642.7 5312.7 5318.6 5341.8 4787.5 5116.2 5125.7 5153.9 5281.5 5157.1 5165.9 5215.4 5223.4 5257.7 4035.5 4192.0 5190.3 5219.3 5226.6 4727.9 5749.3 5810.6 5864.8 5885.6 5410.6 5878.5 6221.1 6262.4 6288.2 6269.7 6279.9 6294.9 6304.3 6321.2 5040.0 5740.5 5857.2 5878.7 5901.9 6318.1 6332.0 6339.2 6351.9 6358.4 6203.8 6221.8 6244.2 6263.3 6265.4 5153.8 6116.2 6223.7 6241.8 6252.1 6204.6 6230.7 6232.0 6259.1 6273.1 6192.3 6221.4 6231.1 6278.9 6281.3 4885.0 4926.0 4970.3 4985.9 5014.3 4437.0 4493.5 4512.9 4537.5 4546.1 5868.6 5952.6 5966.4 5980.9 5983.0 6175.9 6194.0 6250.2 6252.5 6273.9 5918.5 5926.7 5957.1 5977.5 5989.8 5500.4 5509.3 5517.0 5520.0 5553.4 6214.0 6309.9 6311.5 6415.1 6438.7 6270.2 6271.2 6277.6 6312.6 6315.2 6352.3 6388.3 6422.0 6435.0 6438.7 6119.7 6203.5 6233.8 6294.7 6307.7 6199.4 6267.6 6279.8 6282.4 6291.2 6207.2 6251.0 6268.5 6270.9 6282.2 6089.4 6116.5 6147.6 6210.8 6236.9 4939.5 5538.0 6126.4 6145.7 6157.3 6177.6 6211.0 6232.3 6240.7 6247.6 4999.3 5302.4 5687.9 6104.8 6110.5 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:69183.51 Median:38502.50 stddev:158741.53 (412.3%) stddev-sans-first:159103.02 12:13:07 INFO - PROCESS | 1644 | Values: 477.9 483.5 508.7 509.7 569.0 30620.4 33678.2 37320.3 39744.6 39835.0 40800.0 41253.6 41287.0 41333.2 41343.0 9555.8 9749.1 9752.6 9774.9 9778.9 9682.0 9732.1 9765.6 9787.7 9801.0 9743.7 9750.0 9777.9 9789.6 9797.4 9694.7 9695.5 9741.3 9751.9 9756.8 9462.1 9484.1 9539.0 9595.5 9608.0 38988.0 39348.6 39373.0 39434.6 39498.6 2648.5 3302.2 3334.6 3500.6 3530.6 28422.0 28572.0 29400.0 29621.6 30542.2 3111.9 3154.3 3160.6 3176.4 3250.0 439467.0 445855.0 446819.0 446977.0 448067.0 33127.8 33185.8 33278.2 33394.8 33399.3 33823.5 34487.5 34616.5 34829.8 34852.1 15914.4 16001.0 16094.4 16118.6 16129.2 12197.9 12277.6 12325.3 12361.2 12382.9 18752.2 18793.0 18793.7 18818.6 18969.1 6877.1 7284.6 7756.7 7950.6 8057.3 887.6 927.7 971.7 987.2 1065.4 26098.6 27526.8 28952.3 29805.1 30238.5 942.4 949.4 1052.9 1096.4 1101.2 14857.0 15514.8 15515.2 15585.1 15648.5 682955.0 701359.0 703749.0 705315.0 706361.0 55763.4 56076.7 56093.7 56233.4 56364.7 1345.1 1356.1 1397.4 1398.2 1398.5 21992.7 25508.7 27944.6 28757.9 29530.9 40447.2 49213.0 49460.8 49594.5 49721.5 597457.0 600437.0 601928.0 601970.0 602213.0 23021.8 26255.1 26281.9 26499.2 26693.2 46273.8 46626.5 46675.3 47927.0 48008.5 28051.9 31139.2 38026.0 38056.9 38638.0 37968.6 38118.8 38957.4 39171.4 39677.6 32078.9 37546.6 38367.0 38723.6 39196.6 33083.3 33676.0 33760.5 34203.0 34450.3 22147.8 25540.1 25680.5 25813.9 25891.7 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:28595.08 Median:237490.00 stddev:69558.01 (29.3%) stddev-sans-first:69720.80 12:13:07 INFO - PROCESS | 1644 | Values: 346.2 357.4 373.8 386.1 404.1 19973.7 20252.4 20859.2 20860.0 21045.4 11450.5 11924.8 12079.4 12090.4 14932.6 5412.5 5670.8 5673.1 5676.1 5685.4 3975.7 5170.6 5580.6 6864.5 6911.6 6762.0 6927.3 6944.5 6946.8 6951.7 5513.5 6825.6 6866.6 6873.8 6912.2 5984.3 6012.6 6027.7 6066.7 6102.9 13175.5 13466.9 13501.9 20118.8 25612.0 2168.8 2216.1 2219.0 2320.0 2395.1 10301.7 10314.7 10329.8 13547.9 13605.3 1899.7 1934.2 1946.9 1961.6 1987.5 128116.4 131731.7 131943.0 132285.7 132771.0 11307.7 11546.7 11707.1 11719.4 11727.9 10919.9 12200.6 14148.4 14381.9 14424.1 8105.7 8241.5 8253.6 8282.4 8381.8 7338.3 8045.4 8168.3 8175.5 8221.3 4204.6 4215.3 4432.8 4519.5 4609.6 1664.9 1784.4 1823.3 1904.0 1971.7 794.3 813.4 877.7 906.6 961.7 16326.3 19771.5 20684.5 20789.6 20903.8 913.8 927.7 929.2 971.0 1015.6 8343.0 10830.9 10930.4 10935.0 11011.7 236766.0 237432.0 237548.0 491704.0 599849.0 133337.0 134484.0 135449.0 135970.0 136746.0 750.6 938.2 963.5 971.1 974.0 18274.9 18554.4 18623.0 18705.0 18757.0 37628.4 56427.0 56674.1 57001.0 57381.7 81676.6 82088.0 82759.9 82998.2 84694.7 7928.4 8011.5 8013.7 8201.9 8315.5 9072.3 11080.3 11897.9 12342.0 13231.7 10873.3 11121.2 11128.6 11231.7 11234.6 10196.9 11046.7 11292.2 11346.8 11459.3 10209.9 11101.3 11412.1 11564.0 11655.4 6525.7 6690.3 7463.5 7664.2 8028.6 8659.4 9587.5 9722.1 10929.0 11138.0 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5748.97 Median:4831.46 stddev:3256.80 (67.4%) stddev-sans-first:3250.13 12:13:07 INFO - PROCESS | 1644 | Values: 1480.1 1498.5 1538.9 1551.9 1878.6 7938.0 8493.1 8636.8 8980.8 9018.3 8642.7 8756.2 8799.4 8808.7 8809.1 2346.1 2376.0 2378.3 2393.2 2396.0 2321.9 2356.2 2368.3 2368.7 2375.9 2334.8 2363.4 2373.6 2375.8 2380.9 2334.1 2347.5 2357.3 2368.6 2368.7 1949.4 2349.2 2351.8 2354.1 2359.6 7385.3 7526.8 8273.6 8874.1 8912.7 4610.5 5269.9 5343.7 5447.2 5455.4 3511.3 3624.1 3678.3 3688.4 3693.2 1076.4 1108.5 1111.5 1133.9 1133.9 11893.0 11929.8 11988.8 11990.4 11992.9 4574.3 4704.3 4864.5 4876.3 4883.9 10055.4 10136.0 10154.8 10177.6 10184.9 5347.9 5350.1 5400.7 5410.8 5422.4 4449.4 4794.4 4907.0 4928.9 4965.1 3855.5 3908.1 3973.9 3988.1 4004.3 1290.1 1296.2 1299.3 1310.3 1321.5 866.6 875.9 909.4 913.6 931.3 4798.4 5888.7 5906.0 5955.3 6180.3 875.9 907.0 913.1 942.4 958.9 3726.8 3889.5 3929.4 4068.6 4167.5 10714.3 10729.5 10738.0 10996.5 11068.7 10946.8 11020.2 11028.0 11045.9 11049.4 6942.6 8181.8 8261.0 8277.1 8400.2 4874.1 5107.0 5331.9 5801.4 6024.9 9297.6 9967.8 10303.7 10314.5 10404.6 10228.2 10325.9 10359.3 10406.4 10411.5 7097.4 7494.9 7572.2 7651.7 7793.8 8597.9 8663.2 8669.7 8678.0 8681.7 7560.5 7631.3 7655.2 7768.8 7816.3 7408.8 7496.2 7498.5 7539.3 7645.2 7031.8 7095.9 7159.9 7182.1 7186.9 4553.4 5019.7 5163.7 5167.7 5183.9 4401.4 5037.8 5124.3 5193.2 5259.7 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4360.06 Median:4766.12 stddev:1325.71 (27.8%) stddev-sans-first:1293.91 12:13:07 INFO - PROCESS | 1644 | Values: 298.9 306.6 313.5 314.2 314.3 4586.8 5291.4 5415.6 5549.3 5594.5 4502.1 4729.2 5348.8 5538.9 5594.6 4057.5 4153.0 4163.3 4184.7 4199.0 3795.8 4065.3 4172.5 4210.9 4218.2 3997.6 4014.5 4037.6 4041.5 4102.0 3324.9 3567.4 3858.1 3949.0 4057.5 3152.0 3285.9 3544.2 3544.5 3553.6 4740.3 4779.9 5319.5 5333.1 5363.7 3732.0 4678.8 4701.6 4716.6 4728.4 4887.5 5042.9 5265.5 5340.3 5829.1 3769.7 3847.3 3876.7 3881.3 3885.7 5599.8 5752.7 6161.0 6176.0 6198.5 3311.6 3526.5 3981.5 3991.0 4003.6 3768.7 4010.5 4044.4 4050.8 4053.0 4709.0 4732.4 4736.8 4770.3 4773.2 4931.8 5922.4 5933.2 5957.6 5980.4 1150.9 1297.6 1349.4 1381.5 1383.6 877.4 890.0 910.4 913.6 914.4 4572.6 5186.7 5218.9 5404.4 5451.3 5667.4 5976.6 5986.5 6025.4 6039.4 5199.7 5233.8 5353.7 5426.4 5433.9 2430.5 2631.8 2649.4 2671.5 2702.1 4502.4 4891.5 5027.6 5125.3 5264.9 4091.8 4749.8 4811.9 5093.0 5169.7 4432.0 4507.0 4834.9 5274.2 5304.2 4473.7 4723.5 4727.6 4762.0 4887.4 3751.4 4873.7 4912.7 4982.6 4995.0 4244.9 4453.9 4992.6 5186.9 5218.1 3104.6 3258.4 3467.9 3478.0 3546.5 4711.6 4961.6 5059.5 5085.6 5095.1 4469.6 4859.9 4865.9 4891.7 4958.9 4293.0 4436.9 4907.5 4930.6 4958.4 4481.3 4708.7 4787.0 4794.9 5122.4 4852.9 5206.9 5856.6 5888.2 5906.3 5092.3 5137.4 5752.1 5759.3 5781.4 12:13:07 INFO - PROCESS | 1644 | 12:13:07 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:24591.11 Median:3800.29 stddev:39333.54 (1035.0%) stddev-sans-first:39403.02 12:13:07 INFO - PROCESS | 1644 | Values: 714.9 716.2 762.3 785.3 801.2 15174.5 15888.8 15888.9 15930.8 15933.0 14311.7 14415.5 14417.8 14438.4 14454.3 665.1 832.5 833.9 856.7 861.0 852.1 852.2 867.4 867.4 873.1 917.7 918.6 919.7 920.8 922.3 888.0 907.4 907.8 909.1 909.6 664.4 675.4 684.2 688.0 688.7 14778.5 14971.4 14987.1 15040.7 15052.2 14362.2 14656.3 14667.3 14705.6 14744.0 10591.2 11852.2 11917.3 12020.6 12167.5 3248.7 3888.1 3913.6 4048.0 4049.7 112769.0 112899.3 112968.0 114997.4 116065.4 9501.4 11100.3 11194.2 11339.5 11442.4 23012.3 23099.3 23245.0 23354.6 23472.4 7274.1 8093.6 8197.0 8257.4 8280.0 4246.2 4544.5 4577.7 4637.5 4728.1 3597.2 3709.1 3725.1 3730.7 3869.9 716.9 733.8 740.5 745.3 746.0 633.9 668.3 682.0 700.6 707.3 8869.8 9310.7 9578.0 9604.4 9644.9 674.8 678.6 685.7 694.3 698.3 4379.2 4644.9 4656.5 4660.2 4678.1 127773.0 168472.0 171027.0 172129.1 177423.0 80878.8 82626.0 101155.0 115006.0 120133.2 103591.4 105013.4 106368.5 109077.5 111462.4 8448.4 8801.7 9332.2 9939.3 10167.2 58014.3 59425.7 60888.7 62310.4 63334.7 74292.3 94742.0 95603.0 96828.0 97089.5 12452.9 12915.8 13628.9 13722.8 13769.9 14610.9 15085.8 15323.2 15334.8 15732.6 12837.6 13536.9 13872.7 14096.4 14114.9 13967.4 14004.9 14011.6 14100.4 14684.6 13621.7 13717.7 13881.4 14010.2 14112.9 9831.7 10999.5 11243.8 11450.4 11627.2 8909.7 11430.6 11440.9 11619.7 11704.0 12:13:07 INFO - PROCESS | 1644 | -------- Summary: end -------- 12:13:07 INFO - PROCESS | 1644 | 12:13:08 INFO - TEST-INFO | 1644: exit 0 12:13:08 INFO - TEST-OK | dromaeo_css | took 1113997ms 12:13:08 INFO - TEST-START | kraken 12:13:08 INFO - operating with platform_type : mac_ 12:13:08 INFO - Initialising browser for kraken test... 12:13:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpRhG8oL/profile http://localhost:49275/getInfo.html) 12:13:10 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 12:13:10 INFO - PROCESS | 1656 | colorDepth:24 12:13:10 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 12:13:10 INFO - PROCESS | 1656 | __metrics 12:13:11 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 12:13:11 INFO - TEST-INFO | 1656: exit 0 12:13:11 INFO - Browser initialized. 12:13:11 INFO - Running cycle 1/1 for kraken test... 12:13:11 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpRhG8oL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:23 INFO - PROCESS | 1658 | RSS: Main: 239509504 12:13:23 INFO - PROCESS | 1658 | 12:13:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:27 INFO - PROCESS | 1658 | RSS: Main: 252198912 12:13:27 INFO - PROCESS | 1658 | 12:13:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 12:13:30 INFO - PROCESS | 1658 | RSS: Main: 260976640 12:13:30 INFO - PROCESS | 1658 | 12:13:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 12:13:35 INFO - PROCESS | 1658 | RSS: Main: 263766016 12:13:35 INFO - PROCESS | 1658 | 12:13:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 12:13:37 INFO - PROCESS | 1658 | RSS: Main: 265109504 12:13:37 INFO - PROCESS | 1658 | 12:13:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:40 INFO - PROCESS | 1658 | RSS: Main: 266907648 12:13:40 INFO - PROCESS | 1658 | 12:13:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:44 INFO - PROCESS | 1658 | RSS: Main: 266924032 12:13:44 INFO - PROCESS | 1658 | 12:13:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:47 INFO - PROCESS | 1658 | RSS: Main: 267239424 12:13:47 INFO - PROCESS | 1658 | 12:13:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 12:13:51 INFO - PROCESS | 1658 | RSS: Main: 267272192 12:13:51 INFO - PROCESS | 1658 | 12:13:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:53 INFO - PROCESS | 1658 | RSS: Main: 267067392 12:13:53 INFO - PROCESS | 1658 | 12:13:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:56 INFO - PROCESS | 1658 | RSS: Main: 267186176 12:13:56 INFO - PROCESS | 1658 | 12:13:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:59 INFO - PROCESS | 1658 | RSS: Main: 267853824 12:13:59 INFO - PROCESS | 1658 | 12:14:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:14:02 INFO - PROCESS | 1658 | RSS: Main: 267436032 12:14:02 INFO - PROCESS | 1658 | 12:14:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:06 INFO - PROCESS | 1658 | RSS: Main: 267350016 12:14:06 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 12:14:08 INFO - PROCESS | 1658 | RSS: Main: 268529664 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | __start_tp_report 12:14:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 12:14:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 12:14:08 INFO - PROCESS | 1658 | |i|pagename|runs| 12:14:08 INFO - PROCESS | 1658 | |0;ai-astar;108;117;109;115;117;118;125;173;165;118 12:14:08 INFO - PROCESS | 1658 | |1;audio-beat-detection;170;111;130;178;141;141;164;142;174;112 12:14:08 INFO - PROCESS | 1658 | |2;audio-dft;204;268;283;229;202;198;215;207;195;189 12:14:08 INFO - PROCESS | 1658 | |3;audio-fft;70;81;74;147;75;85;86;84;142;63 12:14:08 INFO - PROCESS | 1658 | |4;audio-oscillator;70;71;117;72;72;95;114;72;74;115 12:14:08 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;98;119;87;97;133;86;91;86;88;85 12:14:08 INFO - PROCESS | 1658 | |6;imaging-darkroom;150;138;96;96;93;97;100;96;94;96 12:14:08 INFO - PROCESS | 1658 | |7;imaging-desaturate;92;101;94;79;147;125;126;107;106;86 12:14:08 INFO - PROCESS | 1658 | |8;json-parse-financial;53;55;59;57;54;60;64;64;76;89 12:14:08 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;63;66;69;75;80;76;76;95;105;105 12:14:08 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;88;90;90;87;87;87;108;81;106;111 12:14:08 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;140;139;141;156;154;127;174;242;174 12:14:08 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;174;177;177;177;178;178;171;168;256;201 12:14:08 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;69;73;71;69;72;70;69;69;74;71 12:14:08 INFO - PROCESS | 1658 | __end_tp_report 12:14:08 INFO - PROCESS | 1658 | __start_cc_report 12:14:08 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1049 12:14:08 INFO - PROCESS | 1658 | __end_cc_report 12:14:08 INFO - PROCESS | 1658 | __startTimestamp1471374848449__endTimestamp 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | ------- Summary: start ------- 12:14:08 INFO - PROCESS | 1658 | Number of tests: 14 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:126.50 Median:118.00 stddev:22.98 (19.5%) stddev-sans-first:23.38 12:14:08 INFO - PROCESS | 1658 | Values: 108.0 117.0 109.0 115.0 117.0 118.0 125.0 173.0 165.0 118.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:153.00 stddev:24.52 (16.0%) stddev-sans-first:24.46 12:14:08 INFO - PROCESS | 1658 | Values: 170.0 111.0 130.0 178.0 141.0 141.0 164.0 142.0 174.0 112.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:219.00 Median:211.00 stddev:31.95 (15.1%) stddev-sans-first:33.43 12:14:08 INFO - PROCESS | 1658 | Values: 204.0 268.0 283.0 229.0 202.0 198.0 215.0 207.0 195.0 189.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:90.70 Median:78.00 stddev:29.28 (37.5%) stddev-sans-first:30.08 12:14:08 INFO - PROCESS | 1658 | Values: 70.0 81.0 74.0 147.0 75.0 85.0 86.0 84.0 142.0 63.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:72.00 stddev:20.72 (28.8%) stddev-sans-first:21.03 12:14:08 INFO - PROCESS | 1658 | Values: 70.0 71.0 117.0 72.0 72.0 95.0 114.0 72.0 74.0 115.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:87.50 stddev:16.28 (18.6%) stddev-sans-first:17.26 12:14:08 INFO - PROCESS | 1658 | Values: 98.0 119.0 87.0 97.0 133.0 86.0 91.0 86.0 88.0 85.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:96.00 stddev:20.52 (21.4%) stddev-sans-first:14.13 12:14:08 INFO - PROCESS | 1658 | Values: 150.0 138.0 96.0 96.0 93.0 97.0 100.0 96.0 94.0 96.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:113.00 stddev:20.91 (18.5%) stddev-sans-first:21.53 12:14:08 INFO - PROCESS | 1658 | Values: 92.0 101.0 94.0 79.0 147.0 125.0 126.0 107.0 106.0 86.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.00 stddev:11.32 (18.3%) stddev-sans-first:11.40 12:14:08 INFO - PROCESS | 1658 | Values: 53.0 55.0 59.0 57.0 54.0 60.0 64.0 64.0 76.0 89.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:75.50 stddev:15.38 (20.4%) stddev-sans-first:14.87 12:14:08 INFO - PROCESS | 1658 | Values: 63.0 66.0 69.0 75.0 80.0 76.0 76.0 95.0 105.0 105.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:87.00 stddev:10.60 (12.2%) stddev-sans-first:11.05 12:14:08 INFO - PROCESS | 1658 | Values: 88.0 90.0 90.0 87.0 87.0 87.0 108.0 81.0 106.0 111.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:155.00 stddev:33.13 (21.4%) stddev-sans-first:34.38 12:14:08 INFO - PROCESS | 1658 | Values: 139.0 140.0 139.0 141.0 156.0 154.0 127.0 174.0 242.0 174.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:177.50 stddev:26.22 (14.8%) stddev-sans-first:27.47 12:14:08 INFO - PROCESS | 1658 | Values: 174.0 177.0 177.0 177.0 178.0 178.0 171.0 168.0 256.0 201.0 12:14:08 INFO - PROCESS | 1658 | 12:14:08 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.83 (2.6%) stddev-sans-first:1.83 12:14:08 INFO - PROCESS | 1658 | Values: 69.0 73.0 71.0 69.0 72.0 70.0 69.0 69.0 74.0 71.0 12:14:08 INFO - PROCESS | 1658 | -------- Summary: end -------- 12:14:08 INFO - PROCESS | 1658 | 12:14:09 INFO - TEST-INFO | 1658: exit 0 12:14:09 INFO - TEST-OK | kraken | took 60925ms 12:14:09 INFO - SUITE-END | took 1174s 12:14:09 INFO - Completed test suite (00:19:35) 12:14:09 INFO - javascript benchmark 12:14:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7236.380690582933, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.159377764892, 3448.1034930917986, 3465.6361082086382, 3496.073540511764, 3504.614492405835, 5768.307803063638, 5814.156947242647, 5817.243758311419, 5862.560307976897, 5908.261467316585, 5847.44449277319, 5862.355140934494, 5908.438698323663, 5952.2262105926275, 5982.371850955641, 5124.4875512448825, 5184.53339199472, 5205.115130427817, 5289.973550132244, 5299.311089558352, 3992.960070399288, 4642.675012749109, 5312.654677445954, 5318.574514038887, 5341.786328546854, 4787.473377928408, 5116.181410974226, 5125.718085505296, 5153.896922061575, 5281.471852814726, 5157.149070403379, 5165.9225111623355, 5215.426303106655, 5223.425423203445, 5257.658252213594, 4035.515738111416, 4192.0, 5190.299309593194, 5219.347581552306, 5226.634135610509, 4727.905441891143, 5749.281339832521, 5810.5932584719085, 5864.76540938362, 5885.588008839383, 5410.594205434569, 5878.5297176225795, 6221.066839973995, 6262.405071518198, 6288.182536270301, 6269.686515674198, 6279.937200627981, 6294.874102517924, 6304.27500837405, 6321.1782468278825, 5040.017196646692, 5740.540756739492, 5857.15071314657, 5878.676672782953, 5901.911471327933, 6318.115463835067, 6331.96834015827, 6339.175907132043, 6351.936480635227, 6358.395952384516, 6203.844903877349, 6221.844453888599, 6244.188255526752, 6263.342349053284, 6265.4361107500545, 5153.819616313411, 6116.214037636738, 6223.657698826518, 6241.75032998684, 6252.124702541648, 6204.627722336674, 6230.688465576703, 6232.0, 6259.0924315973925, 6273.0904018917, 6192.349803270682, 6221.353296459408, 6231.096491008779, 6278.937210627835, 6281.309056003836, 4885.0, 4925.950740492549, 4970.329005584272, 4985.850424487271, 5014.348134742533, 4437.001674623184, 4493.483249426293, 4512.932306015412, 4537.546245375502, 4546.1135078659345, 5868.589198756046, 5952.613080149777, 5966.433188847052, 5980.85047873798, 5982.970085149634, 6175.938240617536, 6194.0, 6250.1874756282305, 6252.468540174136, 6273.9372606273355, 5918.467337939606, 5926.67403292823, 5957.106434034929, 5977.491913187428, 5989.760409583655, 5500.367457742331, 5509.256250406143, 5516.979358818631, 5519.972400137974, 5553.389127196006, 6213.96893015532, 6309.936900631119, 6311.463525600376, 6415.06981487691, 6438.710258038306, 6270.216222972129, 6271.153394291895, 6277.5605707600025, 6312.621242725268, 6315.242170939517, 6352.269489008823, 6388.2972872984865, 6421.967890160519, 6434.967825160844, 6438.7102580384935, 6119.654885716854, 6203.534734894991, 6233.7844120396085, 6294.748210071546, 6307.716152773228, 6199.380061993765, 6267.561270711007, 6279.811605651837, 6282.434580887742, 6291.213598300213, 6207.162033125651, 6251.031090181029, 6268.4671802897265, 6270.9372906270355, 6282.183316168869, 6089.421504957022, 6116.548817443993, 6147.616786223064, 6210.7515699373325, 6236.875262494816, 4939.506049395175, 5538.030844602098, 6126.387361263838, 6145.66198859067, 6157.322694503511, 6177.62934223948, 6211.0372892201785, 6232.314445411092, 6240.719167637377, 6247.625142491465, 4999.300097986212, 5302.390225124006, 5687.9431205687415, 6104.755809767737, 6110.450059494667], "value": 5705.123084193503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.9498152693967, 483.5333902783815, 508.74308474220516, 509.6890896553103, 568.9985625299473, 30620.387592248197, 33678.15804604886, 37320.25359492809, 39744.60255397445, 39835.00412489689, 40800.0, 41253.58746412535, 41287.0, 41333.173336533255, 41343.0, 9555.761105972371, 9749.07383798538, 9752.561134748918, 9774.853377199348, 9778.90221097787, 9682.0, 9732.124108830203, 9765.609375625001, 9787.657431989881, 9801.0, 9743.658971935984, 9749.976252493492, 9777.853332200022, 9789.608415663364, 9797.412155270671, 9694.709158725249, 9695.51522423876, 9741.31810773246, 9751.853722194173, 9756.804863902753, 9462.101100395452, 9484.099010593982, 9539.0, 9595.472249026301, 9608.039196080406, 38988.0, 39348.60651393478, 39373.0, 39434.60565394338, 39498.60501394978, 2648.4835457085874, 3302.207470207133, 3334.61651910031, 3500.6324335944614, 3530.6292839252023, 28422.0, 28572.0, 29400.0, 29621.555676664866, 30542.236444088852, 3111.9222019449467, 3154.306052668432, 3160.5575219469292, 3176.4123637127204, 3250.0, 439467.0, 445855.0, 446819.0, 446977.0, 448067.0, 33127.83436082804, 33185.83407082949, 33278.168045798564, 33394.83118090855, 33399.33201336008, 33823.49264761031, 34487.4826877597, 34616.48075278873, 34829.82585087109, 34852.128696782784, 15914.363425463083, 16001.0, 16094.356225750838, 16118.597035074217, 16129.193540323171, 12197.939010304892, 12277.570285039981, 12325.260484370967, 12361.196522226026, 12382.947449466896, 18752.156152973148, 18793.0, 18793.718094228596, 18818.623627527373, 18969.146388412555, 6877.105976223059, 7284.599347035964, 7756.672998100547, 7950.562719050507, 8057.31512821405, 887.5695287785419, 927.6892241099307, 971.6502059258661, 987.1609132237684, 1065.350136416785, 26098.608520872203, 27526.76129574174, 28952.276193095342, 29805.10584682463, 30238.54642180369, 942.4486675294892, 949.4255975135083, 1052.9417934975454, 1096.3969816600838, 1101.1851230089676, 14857.0, 15514.767278490832, 15515.182871015215, 15585.142817145166, 15648.530544083696, 682955.0, 701359.0, 703749.0, 705315.0, 706361.0, 55763.44236557664, 56076.71961640166, 56093.71953140208, 56233.43766562364, 56364.71817640885, 1345.078621144519, 1356.0507644648785, 1397.371182967689, 1398.189050350794, 1398.5175114585452, 21992.670109948045, 25508.744912551378, 27944.580831287953, 28757.85621071965, 29530.852345738134, 40447.1910561793, 49213.0, 49460.75269623629, 49594.50405495899, 49721.502784971686, 597457.0, 600437.0, 601928.0, 601970.0, 602213.0, 23021.769782301963, 26255.081072162382, 26281.948722050904, 26499.205023849314, 26693.19920402391, 46273.76863115663, 46626.53373466358, 46675.29987050129, 47927.0, 48008.5199148018, 28051.85974070198, 31139.221519462193, 38026.0, 38056.858294251215, 38638.0, 37968.62031379761, 38118.809405952794, 38957.41563876601, 39171.43314267397, 39677.60322396739, 32078.877239297446, 37546.62453375541, 38367.0, 38723.61276387313, 39196.60803391929, 33083.33833323368, 33676.0, 33760.49359259564, 34203.0, 34450.310993780484, 22147.778522215216, 25540.10609628654, 25680.472783577683, 25813.870930645226, 25891.741082589688], "value": 18987.904621195208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.22272997121456, 357.39064894355124, 373.7944130728099, 386.05994403627153, 404.12708549533016, 19973.700394494095, 20252.39242822716, 20859.165633374665, 20860.0, 21045.368638940818, 11450.48472818723, 11924.761504769922, 12079.396030198499, 12090.395480225976, 14932.626684332898, 5412.4587541245855, 5670.829875103733, 5673.092305231164, 5676.120201368773, 5685.37460879305, 3975.741576797499, 5170.586353091762, 5580.581456390767, 6864.450843932498, 6911.619860907648, 6761.966190169042, 6927.3419025192525, 6944.51388402812, 6946.791596252096, 6951.721931122749, 5513.5037846594, 6825.55633883796, 6866.553674011173, 6873.828154296132, 6912.205096413902, 5984.281886173687, 6012.6392416455155, 6027.7287522061615, 6066.726997285133, 6102.908456373158, 13175.538856140085, 13466.865331346658, 13501.864981350258, 20118.79881201184, 25612.0, 2168.8048075673264, 2216.091402524973, 2218.9556208875892, 2319.988400058006, 2395.0898658509827, 10301.690949271533, 10314.690559283234, 10329.793404131875, 13547.864521354759, 13605.31973401326, 1899.705545640428, 1934.2263094762068, 1946.9415917522497, 1961.6076784643128, 1987.4832543538785, 128116.35941820231, 131731.68268317386, 131943.0, 132285.6771432283, 132771.0, 11307.660770176743, 11546.711332216593, 11707.121965852595, 11719.355435450962, 11727.882721172678, 10919.890801091888, 12200.633980980585, 14148.43406263738, 14381.92135589835, 14424.06243594163, 8105.6757729691335, 8241.546714930617, 8253.628586713612, 8282.420230583923, 8381.832363352698, 7338.302861228175, 8045.356371490267, 8168.305694016075, 8175.509469431853, 8221.342292616577, 4204.579542045833, 4215.283401821697, 4432.756198409118, 4519.457665080211, 4609.631229501631, 1664.8668106551447, 1784.4111443223705, 1823.3228846334657, 1903.971440428367, 1971.7338159348592, 794.3168874767695, 813.4427916876958, 877.6840337478502, 906.582971832951, 961.6874515782399, 16326.346946122023, 19771.50571235702, 20684.48288792762, 20789.584208315748, 20903.79096209049, 913.8446464101119, 927.7495076329353, 929.1544694328129, 970.9951450242703, 1015.5633077776627, 8343.0, 10830.916908309106, 10930.398828064534, 10935.0, 11011.724706882393, 236766.0, 237432.0, 237548.0, 491704.0, 599849.0, 133337.0, 134484.0, 135449.0, 135970.0, 136746.0, 750.6246876561719, 938.1978408460805, 963.5375019990444, 971.1162841813915, 974.0454354732402, 18274.90862545679, 18554.44336669902, 18623.0, 18705.0, 18757.0, 37628.435573465875, 56427.0, 56674.14988775089, 57001.0, 57381.71309143428, 81676.59161704153, 82088.0, 82759.85059395942, 82998.17001829905, 84694.72957905513, 7928.365730741642, 8011.479253848481, 8013.6794528218215, 8201.876971845308, 8315.459495132796, 9072.274218062672, 11080.279781814157, 11897.940510297392, 12342.0, 13231.66920826987, 10873.293235939638, 11121.221514493907, 11128.610498632834, 11231.719207019563, 11234.550617975516, 10196.898031019595, 11046.723831904266, 11292.209545331747, 11346.773064538498, 11459.255148415326, 10209.897901020895, 11101.278416902875, 11412.144089193178, 11563.95924366811, 11655.358955257543, 6525.673716314261, 6690.330966903271, 7463.514871533333, 7664.195259497673, 8028.59857007159, 8659.437136586102, 9587.472689001892, 9722.076402741728, 10929.0, 11137.99758021782], "value": 9183.500071345026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.0601617972588, 1498.460554200487, 1538.8845836562257, 1551.868091212247, 1878.6242751449713, 7938.0, 8493.065762766098, 8636.827263454743, 8980.77548061298, 9018.278537716984, 8642.697505587306, 8756.168164024424, 8799.384043116985, 8808.735737927873, 8809.075047120055, 2346.1319311854636, 2376.0495801679294, 2378.2508509819436, 2393.234165067179, 2396.0, 2321.9071237150492, 2356.2460012795914, 2368.301351101429, 2368.7157541095094, 2375.9406014849683, 2334.7898689117974, 2363.361892289081, 2373.620220764678, 2375.8336916415856, 2380.8809559521956, 2334.1480359668767, 2347.5187586544716, 2357.257463898875, 2368.5736567417857, 2368.6920700309024, 1949.3859434278156, 2349.1660460536436, 2351.811855051592, 2354.0701422938014, 2359.5634807560655, 7385.29839665231, 7526.774196774106, 8273.627686754111, 8874.112588741074, 8912.732618021404, 4610.5389461053965, 5269.86825329366, 5343.65266257692, 5447.237386765856, 5455.372632147274, 3511.262634846685, 3624.1483251435893, 3678.2643471305846, 3688.3729765939856, 3693.2059607184583, 1076.359566058194, 1108.5233349659643, 1111.4887151910132, 1133.8525991621118, 1133.9489722962487, 11893.0, 11929.761404771943, 11988.760224795542, 11990.400479976053, 11992.880071199264, 4574.336721175411, 4704.317873908264, 4864.513548645107, 4876.268559716071, 4883.926741098886, 10055.39667619945, 10136.037076477724, 10154.796904062025, 10177.643782467578, 10184.949075254724, 5347.919781203285, 5350.117230656976, 5400.702961337164, 5410.78356865721, 5422.40353561108, 4449.354843547668, 4794.4486384065585, 4906.975465122651, 4928.926066109011, 4965.056639238605, 3855.4987851579117, 3908.101136738566, 3973.9071755267532, 3988.105649816372, 4004.3192657248337, 1290.0840403313564, 1296.1704509114174, 1299.2789002103923, 1310.3186343101534, 1321.4582021371384, 866.6360128745941, 875.8861348024843, 909.4497828813472, 913.5751875377981, 931.329442801182, 4798.4001999750035, 5888.735006924699, 5906.0, 5955.255593050869, 6180.3201647818705, 875.8598624220094, 907.0, 913.1279627955287, 942.3780304998668, 958.8945216026232, 3726.832292546842, 3889.5219816470126, 3929.3713005918917, 4068.572799856032, 4167.541570427251, 10714.303570267908, 10729.517171727291, 10738.0, 10996.450177491093, 11068.723281918017, 10946.835797463045, 11020.228583999204, 11028.0, 11045.944770276097, 11049.447527623586, 6942.583444993316, 8181.836363272701, 8261.008678958564, 8277.089520152898, 8400.201980811813, 4874.147024270809, 5106.95307461962, 5331.893362132658, 5801.419858014165, 6024.90962635552, 9297.6280948764, 9967.800643987224, 10303.690889273334, 10314.484275786332, 10404.635837745642, 10228.181745460197, 10325.896741032493, 10359.274850760374, 10406.427646479517, 10411.531481083219, 7097.396721278543, 7494.887576686463, 7572.20491848348, 7651.732189373345, 7793.766187014398, 8597.8710319344, 8663.176998185163, 8669.653213871374, 8677.956610216908, 8681.696140635047, 7560.470767046474, 7631.3131818136635, 7655.157932627518, 7768.805779855549, 7816.257455541714, 7408.814779630552, 7496.212897645669, 7498.475106742694, 7539.32146106853, 7645.159032506531, 7031.824204394931, 7095.858082838211, 7159.928400715926, 7182.102237220348, 7186.856262874818, 4553.3852929855375, 5019.7490125494305, 5163.741812909265, 5167.715775632376, 5183.896322073613, 4401.405810215708, 5037.798488060436, 5124.256982737407, 5193.169092945262, 5259.7370131494035], "value": 4610.354147292446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.92377443751855, 306.628978935488, 313.49996755175493, 314.16275625458155, 314.3147937496259, 4586.770661466926, 5291.417944026163, 5415.64798288111, 5549.250851135095, 5594.468525490072, 4502.144592527417, 4729.196036673765, 5348.839534813962, 5538.944610553894, 5594.580406469521, 4057.452243947066, 4152.958470415302, 4163.271427500175, 4184.66522678185, 4198.979005104986, 3795.7912314822674, 4065.308897487434, 4172.457580514529, 4210.936835947463, 4218.219629368561, 3997.6402123808853, 4014.498187726534, 4037.636612704856, 4041.454403655513, 4101.958980410188, 3324.9168770780925, 3567.4470457078933, 3858.054776579742, 3949.0, 4057.4725285712816, 3152.0, 3285.8685652573868, 3544.1848374873666, 3544.4506101554302, 3553.626869178751, 4740.312654665088, 4779.924516983651, 5319.5478384337375, 5333.146696528537, 5363.712708949863, 3731.9626803731885, 4678.789454474557, 4701.600363969067, 4716.622670186377, 4728.38530990969, 4887.535684110004, 5042.899142017176, 5265.473452654742, 5340.279062326614, 5829.067349224146, 3769.6795772359383, 3847.3459511883048, 3876.7480113792512, 3881.2819628368843, 3885.669718073967, 5599.832005039855, 5752.683602401867, 6160.983437732769, 6176.0118381059265, 6198.543342314552, 3311.6357200707903, 3526.453399723047, 3981.462502562175, 3991.0, 4003.559608443069, 3768.66212494566, 4010.538788039413, 4044.3933409988736, 4050.797460126982, 4052.959470405317, 4709.0, 4732.432108147044, 4736.834210802605, 4770.284457331428, 4773.212419950669, 4931.753412329369, 5922.437368449991, 5933.228680271537, 5957.6127551709, 5980.401959803985, 1150.8561429821273, 1297.5718013055669, 1349.3657980749033, 1381.4819442708983, 1383.6471699716508, 877.4472082588056, 889.9599518021705, 910.4446287764458, 913.5523593439167, 914.3782228084966, 4572.588467037916, 5186.714730689773, 5218.930119325529, 5404.405515393303, 5451.291332126877, 5667.376588575254, 5976.581639285208, 5986.5210783137245, 6025.367336429699, 6039.4262545058145, 5199.714015729096, 5233.790648374099, 5353.652012619167, 5426.375966763794, 5433.918491222635, 2430.501747141832, 2631.7762990146052, 2649.417128231786, 2671.49241644087, 2702.095023008774, 4502.3980815347595, 4891.461939186686, 5027.597792176617, 5125.282460455539, 5264.894702105937, 4091.7954102294766, 4749.810007599657, 4811.917318603286, 5093.0, 5169.71566563835, 4431.977840110779, 4506.954930450719, 4834.854954351375, 5274.176222239, 5304.2230852664015, 4473.731576105444, 4723.527647235249, 4727.645426593088, 4761.952380476151, 4887.36464259644, 3751.4408466938594, 4873.658843880894, 4912.729799861042, 4982.611823959742, 4995.027958364767, 4244.87265382039, 4453.933191002202, 4992.600591952562, 5186.922196167136, 5218.051800732574, 3104.642966058842, 3258.4033823426826, 3467.878624248139, 3477.982610086933, 3546.4503002034726, 4711.552402521755, 4961.603071754179, 5059.494050594911, 5085.567726743268, 5095.140273799962, 4469.5530446955045, 4859.878503037311, 4865.927011094907, 4891.706497610155, 4958.8760280993265, 4292.9608435993905, 4436.933445998248, 4907.533784290486, 4930.580900623487, 4958.380202474691, 4481.327800829901, 4708.741019243975, 4786.9655396457065, 4794.9280760787915, 5122.410922743932, 4852.902941941212, 5206.927912531624, 5856.619319744203, 5888.175655408332, 5906.26171728534, 5092.261622064706, 5137.434882163034, 5752.088579765799, 5759.337676167294, 5781.392953739965], "value": 3947.7853895025155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9356557909789, 716.2050124361961, 762.3215338348871, 785.2696991797633, 801.1988011988012, 15174.468893588726, 15888.841111588881, 15888.920555397235, 15930.840691593081, 15933.0, 14311.713765724679, 14415.495457658984, 14417.78373324401, 14438.350274237659, 14454.349554270057, 665.0523004718282, 832.4505826154755, 833.912439193885, 856.7001549457702, 860.9827803443927, 852.1010334097525, 852.1606217875419, 867.371155911965, 867.4101610904582, 873.0527377795069, 917.7430319510547, 918.6187732091207, 919.6505327975393, 920.802027564077, 922.2667978956746, 887.9644814207423, 907.4328544659588, 907.8093600343869, 909.0545832334365, 909.5679552212679, 664.3688495928886, 675.4022689919408, 684.2029036172853, 687.9793606191822, 688.6900894597451, 14778.482753103697, 14971.401143954228, 14987.100773953598, 15040.699186016327, 15052.247387630574, 14362.210078445682, 14656.267186640625, 14667.266636668232, 14705.558833234913, 14744.0, 10591.205659575562, 11852.229605075643, 11917.284962902168, 12020.579279725254, 12167.452464639113, 3248.6751324867323, 3888.1251718363424, 3913.571546385577, 4047.97976010121, 4049.696272779524, 112769.0, 112899.30651040158, 112968.0, 114997.4250128744, 116065.41967290195, 9501.42991420517, 11100.278481898651, 11194.216404851582, 11339.489722962486, 11442.427878606037, 23012.309630711105, 23099.3070207894, 23245.0, 23354.64968025481, 23472.413189670053, 7274.090738657668, 8093.554854482943, 8196.959015204886, 8257.42198046131, 8280.0, 4246.193223287565, 4544.522825103382, 4577.656675749332, 4637.466691330473, 4728.148933191989, 3597.172650290448, 3709.0541911812315, 3725.0873535983314, 3730.6642402183934, 3869.9226015480094, 716.8924661300847, 733.8385555177853, 740.5482655580092, 745.284526854226, 745.9738909138155, 633.8859005379076, 668.2682462703332, 681.9659017049128, 700.6496751624188, 707.3492387003865, 8869.778255543533, 9310.674126405678, 9577.952110239405, 9604.38785192993, 9644.855327170098, 674.8312921769558, 678.5521555773265, 685.6503183376415, 694.298758254167, 698.2982102986466, 4379.211741886427, 4644.883877903079, 4656.464506581787, 4660.184467718136, 4678.134545109166, 127773.0, 168472.0, 171027.01405450748, 172129.13935430493, 177423.0, 80878.78681819777, 82626.0, 101155.0, 115006.0, 120133.20285976803, 103591.44612830965, 105013.37466563244, 106368.46815765872, 109077.45461272643, 111462.44268778604, 8448.366372522209, 8801.735947921572, 9332.16010559053, 9939.254555908192, 10167.237457190593, 58014.279028547026, 59425.7028714871, 60888.69555652371, 62310.442238944386, 63334.68332658307, 74292.25707742853, 94742.0, 95603.0, 96828.0, 97089.51455242679, 12452.875471245172, 12915.806262906252, 13628.93185534066, 13722.794158087836, 13769.862301376857, 14610.853891461375, 15085.773713394527, 15323.233838307817, 15334.846651533342, 15732.60668483297, 12837.587865334992, 13536.864631353561, 13872.722545548831, 14096.436142554183, 14114.929425352808, 13967.441302347792, 14004.859951400356, 14011.649708757363, 14100.36548355306, 14684.632884177981, 13621.659458513617, 13717.725645486835, 13881.444742210198, 14010.229437381042, 14112.929435352757, 9831.705048848546, 10999.505022273857, 11243.775124497628, 11450.427478626201, 11627.244229125079, 8909.73270801877, 11430.599929002445, 11440.885591143982, 11619.709507262387, 11704.005159561533], "value": 7929.488248415285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1631.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 109.0, 115.0, 117.0, 118.0, 125.0, 173.0, 165.0, 118.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 111.0, 130.0, 178.0, 141.0, 141.0, 164.0, 142.0, 174.0, 112.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 268.0, 283.0, 229.0, 202.0, 198.0, 215.0, 207.0, 195.0, 189.0], "value": 219.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 74.0, 147.0, 75.0, 85.0, 86.0, 84.0, 142.0, 63.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 117.0, 72.0, 72.0, 95.0, 114.0, 72.0, 74.0, 115.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 119.0, 87.0, 97.0, 133.0, 86.0, 91.0, 86.0, 88.0, 85.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 138.0, 96.0, 96.0, 93.0, 97.0, 100.0, 96.0, 94.0, 96.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 101.0, 94.0, 79.0, 147.0, 125.0, 126.0, 107.0, 106.0, 86.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 59.0, 57.0, 54.0, 60.0, 64.0, 64.0, 76.0, 89.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 69.0, 75.0, 80.0, 76.0, 76.0, 95.0, 105.0, 105.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 90.0, 87.0, 87.0, 87.0, 108.0, 81.0, 106.0, 111.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 139.0, 141.0, 156.0, 154.0, 127.0, 174.0, 242.0, 174.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 177.0, 177.0, 178.0, 178.0, 171.0, 168.0, 256.0, 201.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 71.0, 69.0, 72.0, 70.0, 69.0, 69.0, 74.0, 71.0], "value": 70.7, "unit": "score"}]}]} 12:14:09 INFO - Return code: 0 12:14:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:14:09 ERROR - # TBPL SUCCESS # 12:14:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:14:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:14:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:14:09 INFO - 2016-08-16 12:14:09.787 screenresolution[1663:10544] starting screenresolution argv=screenresolution get 12:14:09 INFO - 2016-08-16 12:14:09.789 screenresolution[1663:10544] Display 0: 1600x1200x32@60 12:14:09 INFO - 2016-08-16 12:14:09.795 screenresolution[1664:10547] starting screenresolution argv=screenresolution list 12:14:09 INFO - Available Modes on Display 0 12:14:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:14:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:14:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:14:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:14:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:14:10 INFO - Intel Iris: 12:14:10 INFO - Chipset Model: Intel Iris 12:14:10 INFO - Type: GPU 12:14:10 INFO - Bus: Built-In 12:14:10 INFO - VRAM (Dynamic, Max): 1536 MB 12:14:10 INFO - Vendor: Intel (0x8086) 12:14:10 INFO - Device ID: 0x0a2e 12:14:10 INFO - Revision ID: 0x0009 12:14:10 INFO - Displays: 12:14:10 INFO - Display: 12:14:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:14:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:14:10 INFO - Display Serial Number: 1600x1200 60 12:14:10 INFO - Main Display: Yes 12:14:10 INFO - Mirror: Off 12:14:10 INFO - Online: Yes 12:14:10 INFO - Rotation: Supported 12:14:10 INFO - Return code: 0 12:14:10 INFO - Running post-action listener: _resource_record_post_action 12:14:10 INFO - [mozharness: 2016-08-16 19:14:10.033222Z] Finished run-tests step (success) 12:14:10 INFO - Running post-run listener: _resource_record_post_run 12:14:10 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 37377024; Write bytes: 705909248; Read time: 380; Write time: 1976 12:14:10 INFO - TinderboxPrint: CPU usage
54.7% 12:14:10 INFO - TinderboxPrint: I/O read bytes / time
37,377,024 / 380 12:14:10 INFO - TinderboxPrint: I/O write bytes / time
705,909,248 / 1,976 12:14:10 INFO - TinderboxPrint: CPU idle
2,193.3 (45.3%) 12:14:10 INFO - TinderboxPrint: CPU system
980.8 (20.3%) 12:14:10 INFO - TinderboxPrint: CPU user
1,667.6 (34.4%) 12:14:10 INFO - TinderboxPrint: Swap in / out
442,662,912 / 0 12:14:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402678272; Write bytes: 397723136; Read time: 30043; Write time: 703 12:14:10 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 34116608; Write bytes: 296160256; Read time: 350; Write time: 1239 12:14:10 INFO - Running post-run listener: _upload_blobber_files 12:14:10 INFO - Blob upload gear active. 12:14:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:10 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 12:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:14:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:12 INFO - (blobuploader) - INFO - Done attempting. 12:14:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:14:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:12 INFO - (blobuploader) - INFO - Done attempting. 12:14:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:15 INFO - (blobuploader) - INFO - Done attempting. 12:14:15 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:15 INFO - Return code: 0 12:14:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44d8ca0dbcb1d8e5b490c307bd81b5e249abc26b39b143df1d75597eee555b1398e645e365b1e766c64ebf0b1e8db4fc8e6eeef808ffe6155f69b7c45e00148f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26fe7f157608ed3a28d8681f2f2c8694b78feca11c18915ffbe6ace90970aeee4ab80df672b0da89d9581c83d23b6aa9af44881fc87a77478985de2e8bbe5c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1995922cc5795a38bdfa829d9ef7808f43fa9fde4ee0f0f956fbdbf0ef3a041fd5e064fcecba1491a244bb784c12540eb6017c1ef8fb3ba63267295cb13e5fd"} 12:14:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:15 INFO - Contents: 12:14:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44d8ca0dbcb1d8e5b490c307bd81b5e249abc26b39b143df1d75597eee555b1398e645e365b1e766c64ebf0b1e8db4fc8e6eeef808ffe6155f69b7c45e00148f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26fe7f157608ed3a28d8681f2f2c8694b78feca11c18915ffbe6ace90970aeee4ab80df672b0da89d9581c83d23b6aa9af44881fc87a77478985de2e8bbe5c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1995922cc5795a38bdfa829d9ef7808f43fa9fde4ee0f0f956fbdbf0ef3a041fd5e064fcecba1491a244bb784c12540eb6017c1ef8fb3ba63267295cb13e5fd"} 12:14:15 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:15 INFO - Copying logs to upload dir... 12:14:15 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.299563 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-16 12:14:15.232764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 12:14:15.236093) ========= 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.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44d8ca0dbcb1d8e5b490c307bd81b5e249abc26b39b143df1d75597eee555b1398e645e365b1e766c64ebf0b1e8db4fc8e6eeef808ffe6155f69b7c45e00148f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26fe7f157608ed3a28d8681f2f2c8694b78feca11c18915ffbe6ace90970aeee4ab80df672b0da89d9581c83d23b6aa9af44881fc87a77478985de2e8bbe5c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1995922cc5795a38bdfa829d9ef7808f43fa9fde4ee0f0f956fbdbf0ef3a041fd5e064fcecba1491a244bb784c12540eb6017c1ef8fb3ba63267295cb13e5fd"} build_url:https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/YguIoJzPQFCqAWSTP9Jo5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44d8ca0dbcb1d8e5b490c307bd81b5e249abc26b39b143df1d75597eee555b1398e645e365b1e766c64ebf0b1e8db4fc8e6eeef808ffe6155f69b7c45e00148f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26fe7f157608ed3a28d8681f2f2c8694b78feca11c18915ffbe6ace90970aeee4ab80df672b0da89d9581c83d23b6aa9af44881fc87a77478985de2e8bbe5c2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1995922cc5795a38bdfa829d9ef7808f43fa9fde4ee0f0f956fbdbf0ef3a041fd5e064fcecba1491a244bb784c12540eb6017c1ef8fb3ba63267295cb13e5fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 12:14:15.269279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:14:15.269675) ========= 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.NPI7LgyN9W/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.eYV49BAXeO/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005258 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 12:14:15.321258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 12:14:15.322047) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 12:14:15.322920) ========= ========= Total master_lag: 0.18 =========