builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1476421201.56 results: success (0) buildid: 20161013190536 builduid: 7a1456f6ff7d4169a6f4f2e1bea24456 revision: 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.560706) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.561567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.562135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.579258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.579861) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 22:00:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-10-13 22:00:02 (219 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.353386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.954373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:01.968220) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016872 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:02.013474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 22:00:02.013897) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 22:00:02,366 truncating revision to first 12 chars 2016-10-13 22:00:02,366 Setting DEBUG logging. 2016-10-13 22:00:02,366 attempt 1/10 2016-10-13 22:00:02,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/47f70e2af768?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 22:00:03,418 unpacking tar archive at: mozilla-aurora-47f70e2af768/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 22:00:03.436568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:03.436953) ========= script_repo_revision: 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:03.437416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:03.437752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 22:00:03.450980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-13 22:00:03.451288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:03 INFO - MultiFileLogger online at 20161013 22:00:03 in /builds/slave/test 22:00:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 22:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:03 INFO - {'append_to_log': False, 22:00:03 INFO - 'base_work_dir': '/builds/slave/test', 22:00:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:03 INFO - 'branch': 'Mozilla-Aurora', 22:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:03 INFO - 'config_files': ('talos/linux_config.py',), 22:00:03 INFO - 'default_actions': ('clobber', 22:00:03 INFO - 'read-buildbot-config', 22:00:03 INFO - 'download-and-extract', 22:00:03 INFO - 'populate-webroot', 22:00:03 INFO - 'create-virtualenv', 22:00:03 INFO - 'install', 22:00:03 INFO - 'run-tests'), 22:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:03 INFO - 'download_minidump_stackwalk': True, 22:00:03 INFO - 'download_symbols': 'ondemand', 22:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:03 INFO - 'installer_path': 'installer.exe', 22:00:03 INFO - 'log_level': 'info', 22:00:03 INFO - 'log_name': 'talos', 22:00:03 INFO - 'log_to_console': True, 22:00:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:03 INFO - 'opt_config_files': (), 22:00:03 INFO - 'pip_index': False, 22:00:03 INFO - 'sps_profile': False, 22:00:03 INFO - 'sps_profile_interval': 0, 22:00:03 INFO - 'suite': 'dromaeojs', 22:00:03 INFO - 'system_bits': '32', 22:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:03 INFO - 'title': 'talos-linux64-ix-022', 22:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:03 INFO - 'use_talos_json': True, 22:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:03 INFO - 'work_dir': 'build'} 22:00:03 INFO - [mozharness: 2016-10-14 05:00:03.895008Z] Running clobber step. 22:00:03 INFO - Running pre-action listener: _resource_record_pre_action 22:00:03 INFO - Running main action method: clobber 22:00:03 INFO - rmtree: /builds/slave/test/build 22:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:04 INFO - Running post-action listener: _resource_record_post_action 22:00:04 INFO - [mozharness: 2016-10-14 05:00:04.359230Z] Finished clobber step (success) 22:00:04 INFO - [mozharness: 2016-10-14 05:00:04.359328Z] Running read-buildbot-config step. 22:00:04 INFO - Running pre-action listener: _resource_record_pre_action 22:00:04 INFO - Running main action method: read_buildbot_config 22:00:04 INFO - Using buildbot properties: 22:00:04 INFO - { 22:00:04 INFO - "project": "", 22:00:04 INFO - "product": "firefox", 22:00:04 INFO - "script_repo_revision": "production", 22:00:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 22:00:04 INFO - "repository": "", 22:00:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 22:00:04 INFO - "buildid": "20161013190536", 22:00:04 INFO - "pgo_build": "True", 22:00:04 INFO - "basedir": "/builds/slave/test", 22:00:04 INFO - "buildnumber": 571, 22:00:04 INFO - "slavename": "talos-linux64-ix-022", 22:00:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:04 INFO - "platform": "ubuntu64_hw", 22:00:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:00:04 INFO - "branch": "mozilla-aurora", 22:00:04 INFO - "repo_path": "releases/mozilla-aurora", 22:00:04 INFO - "revision": "47f70e2af768c0a48ac6c938a1cf89f1e9d1138c", 22:00:04 INFO - "stage_platform": "linux64-pgo", 22:00:04 INFO - "builduid": "7a1456f6ff7d4169a6f4f2e1bea24456", 22:00:04 INFO - "slavebuilddir": "test" 22:00:04 INFO - } 22:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 22:00:04 INFO - Running post-action listener: _resource_record_post_action 22:00:04 INFO - [mozharness: 2016-10-14 05:00:04.361778Z] Finished read-buildbot-config step (success) 22:00:04 INFO - [mozharness: 2016-10-14 05:00:04.361868Z] Running download-and-extract step. 22:00:04 INFO - Running pre-action listener: _resource_record_pre_action 22:00:04 INFO - Running main action method: download_and_extract 22:00:04 INFO - mkdir: /builds/slave/test/build/tests 22:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:04 INFO - trying https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:00:04 INFO - Downloaded 1361 bytes. 22:00:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 22:00:04 INFO - Using the following test package requirements: 22:00:04 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:00:04 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:04 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:00:04 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'jsshell-linux-x86_64.zip'], 22:00:04 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:04 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 22:00:04 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:00:04 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:00:04 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:04 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 22:00:04 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:04 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:00:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:04 INFO - Fetch https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:00:05 INFO - Expected file size: 21905934 22:00:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 22:00:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:09 INFO - Fetch https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 22:00:10 INFO - Expected file size: 21905934 22:00:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 22:00:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:00:15 INFO - Fetch https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 22:00:15 INFO - Expected file size: 14414059 22:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:16 INFO - trying https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:00:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:00:17 INFO - Downloaded 64004959 bytes. 22:00:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:00:17 INFO - mkdir: /builds/slave/test/properties 22:00:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:00:17 INFO - Writing to file /builds/slave/test/properties/build_url 22:00:17 INFO - Contents: 22:00:17 INFO - build_url:https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 22:00:18 INFO - Running post-action listener: _resource_record_post_action 22:00:18 INFO - Running post-action listener: set_extra_try_arguments 22:00:18 INFO - [mozharness: 2016-10-14 05:00:18.139879Z] Finished download-and-extract step (success) 22:00:18 INFO - [mozharness: 2016-10-14 05:00:18.140146Z] Running populate-webroot step. 22:00:18 INFO - Running pre-action listener: _resource_record_pre_action 22:00:18 INFO - Running main action method: populate_webroot 22:00:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:18 INFO - '--tppagecycles', 22:00:18 INFO - '7'], 22:00:18 INFO - 'tests': ['tsvgm']}}, 22:00:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:00:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:00:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:00:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['damp', 'tps']}, 22:00:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'tests': ['damp', 'tps']}, 22:00:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['dromaeo_dom']}, 22:00:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['basic_compositor_video']}, 22:00:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:00:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'other-e10s': {'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['a11yr', 22:00:18 INFO - 'ts_paint', 22:00:18 INFO - 'tpaint', 22:00:18 INFO - 'sessionrestore', 22:00:18 INFO - 'sessionrestore_no_auto_restore', 22:00:18 INFO - 'tabpaint']}, 22:00:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['tsvgx', 22:00:18 INFO - 'tsvgr_opacity', 22:00:18 INFO - 'tart', 22:00:18 INFO - 'tscrollx', 22:00:18 INFO - 'cart']}, 22:00:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:00:18 INFO - 'tsvgr_opacity', 22:00:18 INFO - 'tart', 22:00:18 INFO - 'tscrollx', 22:00:18 INFO - 'cart']}, 22:00:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'talos_options': ['--disable-e10s'], 22:00:18 INFO - 'tests': ['tp5o']}, 22:00:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'tests': ['tp5o']}, 22:00:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'talos_options': ['--disable-e10s', 22:00:18 INFO - '--xperf_path', 22:00:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:18 INFO - 'tests': ['tp5n']}, 22:00:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:18 INFO - 'talos_options': ['--xperf_path', 22:00:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:18 INFO - 'tests': ['tp5n']}}, 22:00:18 INFO - 'talos.zip': {'path': '', 22:00:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:18 INFO - Running post-action listener: _resource_record_post_action 22:00:18 INFO - [mozharness: 2016-10-14 05:00:18.158586Z] Finished populate-webroot step (success) 22:00:18 INFO - [mozharness: 2016-10-14 05:00:18.158674Z] Running create-virtualenv step. 22:00:18 INFO - Running pre-action listener: _resource_record_pre_action 22:00:18 INFO - Running main action method: create_virtualenv 22:00:18 INFO - Creating virtualenv /builds/slave/test/build/venv 22:00:18 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 22:00:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:00:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:18 INFO - Using real prefix '/usr' 22:00:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:00:18 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:20 INFO - Installing pip.................done. 22:00:20 INFO - Return code: 0 22:00:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:00:20 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')]} 22:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:20 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')]} 22:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:20 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:20 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 22:00:20 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 22:00:20 INFO - Using env: {'DISPLAY': ':0', 22:00:20 INFO - 'HOME': '/home/cltbld', 22:00:20 INFO - 'LANG': 'en_US.UTF-8', 22:00:20 INFO - 'LANGUAGE': 'en_US:en', 22:00:20 INFO - 'LOGNAME': 'cltbld', 22:00:20 INFO - 'MAIL': '/var/mail/cltbld', 22:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:20 INFO - 'MOZ_NO_REMOTE': '1', 22:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:20 INFO - 'NO_EM_RESTART': '1', 22:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:20 INFO - 'PWD': '/builds/slave/test', 22:00:20 INFO - 'SHELL': '/bin/bash', 22:00:20 INFO - 'SHLVL': '1', 22:00:20 INFO - 'TERM': 'linux', 22:00:20 INFO - 'TMOUT': '86400', 22:00:20 INFO - 'USER': 'cltbld', 22:00:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:20 INFO - '_': '/tools/buildbot/bin/python'} 22:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:20 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 22:00:20 INFO - Cleaning up... 22:00:20 INFO - Return code: 0 22:00:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:00:20 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')]} 22:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:20 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')]} 22:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:20 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:20 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 22:00:20 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 22:00:20 INFO - Using env: {'DISPLAY': ':0', 22:00:20 INFO - 'HOME': '/home/cltbld', 22:00:20 INFO - 'LANG': 'en_US.UTF-8', 22:00:20 INFO - 'LANGUAGE': 'en_US:en', 22:00:20 INFO - 'LOGNAME': 'cltbld', 22:00:20 INFO - 'MAIL': '/var/mail/cltbld', 22:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:20 INFO - 'MOZ_NO_REMOTE': '1', 22:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:20 INFO - 'NO_EM_RESTART': '1', 22:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:20 INFO - 'PWD': '/builds/slave/test', 22:00:20 INFO - 'SHELL': '/bin/bash', 22:00:20 INFO - 'SHLVL': '1', 22:00:20 INFO - 'TERM': 'linux', 22:00:20 INFO - 'TMOUT': '86400', 22:00:20 INFO - 'USER': 'cltbld', 22:00:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:20 INFO - '_': '/tools/buildbot/bin/python'} 22:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:21 INFO - Downloading/unpacking psutil>=3.1.1 22:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:23 INFO - Installing collected packages: psutil 22:00:23 INFO - Running setup.py install for psutil 22:00:23 INFO - building 'psutil._psutil_linux' extension 22:00:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:00:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:00:23 INFO - building 'psutil._psutil_posix' extension 22:00:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:00:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:00:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:23 INFO - Successfully installed psutil 22:00:23 INFO - Cleaning up... 22:00:23 INFO - Return code: 0 22:00:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:00:23 INFO - Using env: {'DISPLAY': ':0', 22:00:23 INFO - 'HOME': '/home/cltbld', 22:00:23 INFO - 'LANG': 'en_US.UTF-8', 22:00:23 INFO - 'LANGUAGE': 'en_US:en', 22:00:23 INFO - 'LOGNAME': 'cltbld', 22:00:23 INFO - 'MAIL': '/var/mail/cltbld', 22:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:23 INFO - 'MOZ_NO_REMOTE': '1', 22:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:23 INFO - 'NO_EM_RESTART': '1', 22:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:23 INFO - 'PWD': '/builds/slave/test', 22:00:23 INFO - 'SHELL': '/bin/bash', 22:00:23 INFO - 'SHLVL': '1', 22:00:23 INFO - 'TERM': 'linux', 22:00:23 INFO - 'TMOUT': '86400', 22:00:23 INFO - 'USER': 'cltbld', 22:00:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:23 INFO - '_': '/tools/buildbot/bin/python'} 22:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:00:23 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 22:00:23 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 22:00:23 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 22:00:23 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 22:00:23 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 22:00:23 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 22:00:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:00:25 INFO - Installing collected packages: mozsystemmonitor 22:00:25 INFO - Running setup.py install for mozsystemmonitor 22:00:26 INFO - Successfully installed mozsystemmonitor 22:00:26 INFO - Cleaning up... 22:00:26 INFO - Return code: 0 22:00:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:26 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:26 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 22:00:26 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 22:00:26 INFO - Using env: {'DISPLAY': ':0', 22:00:26 INFO - 'HOME': '/home/cltbld', 22:00:26 INFO - 'LANG': 'en_US.UTF-8', 22:00:26 INFO - 'LANGUAGE': 'en_US:en', 22:00:26 INFO - 'LOGNAME': 'cltbld', 22:00:26 INFO - 'MAIL': '/var/mail/cltbld', 22:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:26 INFO - 'MOZ_NO_REMOTE': '1', 22:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:26 INFO - 'NO_EM_RESTART': '1', 22:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:26 INFO - 'PWD': '/builds/slave/test', 22:00:26 INFO - 'SHELL': '/bin/bash', 22:00:26 INFO - 'SHLVL': '1', 22:00:26 INFO - 'TERM': 'linux', 22:00:26 INFO - 'TMOUT': '86400', 22:00:26 INFO - 'USER': 'cltbld', 22:00:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:26 INFO - '_': '/tools/buildbot/bin/python'} 22:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:26 INFO - Downloading/unpacking jsonschema==2.5.1 22:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:28 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:28 INFO - warning: no files found matching '*.txt' 22:00:28 INFO - no previously-included directories found matching 'build' 22:00:28 INFO - no previously-included directories found matching 'dist' 22:00:28 INFO - no previously-included directories found matching '.git*' 22:00:28 INFO - Installing collected packages: jsonschema, functools32 22:00:28 INFO - Running setup.py install for functools32 22:00:28 INFO - warning: no files found matching '*.txt' 22:00:28 INFO - no previously-included directories found matching 'build' 22:00:28 INFO - no previously-included directories found matching 'dist' 22:00:28 INFO - no previously-included directories found matching '.git*' 22:00:28 INFO - Successfully installed jsonschema functools32 22:00:28 INFO - Cleaning up... 22:00:28 INFO - Return code: 0 22:00:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:00:28 INFO - Using env: {'DISPLAY': ':0', 22:00:28 INFO - 'HOME': '/home/cltbld', 22:00:28 INFO - 'LANG': 'en_US.UTF-8', 22:00:28 INFO - 'LANGUAGE': 'en_US:en', 22:00:28 INFO - 'LOGNAME': 'cltbld', 22:00:28 INFO - 'MAIL': '/var/mail/cltbld', 22:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:28 INFO - 'MOZ_NO_REMOTE': '1', 22:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:28 INFO - 'NO_EM_RESTART': '1', 22:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:28 INFO - 'PWD': '/builds/slave/test', 22:00:28 INFO - 'SHELL': '/bin/bash', 22:00:28 INFO - 'SHLVL': '1', 22:00:28 INFO - 'TERM': 'linux', 22:00:28 INFO - 'TMOUT': '86400', 22:00:28 INFO - 'USER': 'cltbld', 22:00:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:28 INFO - '_': '/tools/buildbot/bin/python'} 22:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:00:28 INFO - Cleaning up... 22:00:28 INFO - Return code: 0 22:00:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:28 INFO - Using env: {'DISPLAY': ':0', 22:00:28 INFO - 'HOME': '/home/cltbld', 22:00:28 INFO - 'LANG': 'en_US.UTF-8', 22:00:28 INFO - 'LANGUAGE': 'en_US:en', 22:00:28 INFO - 'LOGNAME': 'cltbld', 22:00:28 INFO - 'MAIL': '/var/mail/cltbld', 22:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:28 INFO - 'MOZ_NO_REMOTE': '1', 22:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:28 INFO - 'NO_EM_RESTART': '1', 22:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:28 INFO - 'PWD': '/builds/slave/test', 22:00:28 INFO - 'SHELL': '/bin/bash', 22:00:28 INFO - 'SHLVL': '1', 22:00:28 INFO - 'TERM': 'linux', 22:00:28 INFO - 'TMOUT': '86400', 22:00:28 INFO - 'USER': 'cltbld', 22:00:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:28 INFO - '_': '/tools/buildbot/bin/python'} 22:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:29 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:29 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 22:00:29 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 22:00:29 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 22:00:29 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 22:00:29 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 22:00:29 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 22:00:31 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:31 INFO - Downloading docopt-0.6.1.tar.gz 22:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:31 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:31 INFO - Running setup.py install for blobuploader 22:00:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:31 INFO - Running setup.py install for requests 22:00:32 INFO - Running setup.py install for docopt 22:00:32 INFO - Successfully installed blobuploader requests docopt 22:00:32 INFO - Cleaning up... 22:00:32 INFO - Return code: 0 22:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:32 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:32 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 22:00:32 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 22:00:32 INFO - Using env: {'DISPLAY': ':0', 22:00:32 INFO - 'HOME': '/home/cltbld', 22:00:32 INFO - 'LANG': 'en_US.UTF-8', 22:00:32 INFO - 'LANGUAGE': 'en_US:en', 22:00:32 INFO - 'LOGNAME': 'cltbld', 22:00:32 INFO - 'MAIL': '/var/mail/cltbld', 22:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:32 INFO - 'MOZ_NO_REMOTE': '1', 22:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:32 INFO - 'NO_EM_RESTART': '1', 22:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:32 INFO - 'PWD': '/builds/slave/test', 22:00:32 INFO - 'SHELL': '/bin/bash', 22:00:32 INFO - 'SHLVL': '1', 22:00:32 INFO - 'TERM': 'linux', 22:00:32 INFO - 'TMOUT': '86400', 22:00:32 INFO - 'USER': 'cltbld', 22:00:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:32 INFO - '_': '/tools/buildbot/bin/python'} 22:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:32 INFO - Running setup.py (path:/tmp/pip-61HT1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:32 INFO - Running setup.py (path:/tmp/pip-ZcNJa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:32 INFO - Running setup.py (path:/tmp/pip-Ia1mVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:32 INFO - Running setup.py (path:/tmp/pip-IJSgn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:32 INFO - Running setup.py (path:/tmp/pip-xznQus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:33 INFO - Running setup.py (path:/tmp/pip-WnsFXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:33 INFO - Running setup.py (path:/tmp/pip-RK1FnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:33 INFO - Running setup.py (path:/tmp/pip-PjWAqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:33 INFO - Running setup.py (path:/tmp/pip-CaCSKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:33 INFO - Running setup.py (path:/tmp/pip-3d3eUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:33 INFO - Running setup.py (path:/tmp/pip-gtEAd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:33 INFO - Running setup.py (path:/tmp/pip-RZYjqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:33 INFO - Running setup.py (path:/tmp/pip-YE3KSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:33 INFO - Running setup.py (path:/tmp/pip-DCKL6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:33 INFO - Running setup.py (path:/tmp/pip-r176Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:33 INFO - Running setup.py (path:/tmp/pip-MW4LYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:33 INFO - Running setup.py (path:/tmp/pip-a5Ovsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:33 INFO - Running setup.py install for manifestparser 22:00:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for mozcrash 22:00:34 INFO - Running setup.py install for mozdebug 22:00:34 INFO - Running setup.py install for mozdevice 22:00:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for mozfile 22:00:34 INFO - Running setup.py install for mozhttpd 22:00:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for mozinfo 22:00:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for mozInstall 22:00:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for mozleak 22:00:34 INFO - Running setup.py install for mozlog 22:00:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:34 INFO - Running setup.py install for moznetwork 22:00:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Running setup.py install for mozprocess 22:00:35 INFO - Running setup.py install for mozprofile 22:00:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Running setup.py install for mozrunner 22:00:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Running setup.py install for mozscreenshot 22:00:35 INFO - Running setup.py install for moztest 22:00:35 INFO - Running setup.py install for mozversion 22:00:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:35 INFO - Cleaning up... 22:00:35 INFO - Return code: 0 22:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:35 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:35 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 22:00:35 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 22:00:35 INFO - Using env: {'DISPLAY': ':0', 22:00:35 INFO - 'HOME': '/home/cltbld', 22:00:35 INFO - 'LANG': 'en_US.UTF-8', 22:00:35 INFO - 'LANGUAGE': 'en_US:en', 22:00:35 INFO - 'LOGNAME': 'cltbld', 22:00:35 INFO - 'MAIL': '/var/mail/cltbld', 22:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:35 INFO - 'MOZ_NO_REMOTE': '1', 22:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:35 INFO - 'NO_EM_RESTART': '1', 22:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:35 INFO - 'PWD': '/builds/slave/test', 22:00:35 INFO - 'SHELL': '/bin/bash', 22:00:35 INFO - 'SHLVL': '1', 22:00:35 INFO - 'TERM': 'linux', 22:00:35 INFO - 'TMOUT': '86400', 22:00:35 INFO - 'USER': 'cltbld', 22:00:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:35 INFO - '_': '/tools/buildbot/bin/python'} 22:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:35 INFO - Running setup.py (path:/tmp/pip-O1TD_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:36 INFO - Running setup.py (path:/tmp/pip-fbMWsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:36 INFO - Running setup.py (path:/tmp/pip-wE0Od4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:36 INFO - Running setup.py (path:/tmp/pip-4r2jLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:36 INFO - Running setup.py (path:/tmp/pip-u6bgHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:36 INFO - Running setup.py (path:/tmp/pip-rMNs3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:36 INFO - Running setup.py (path:/tmp/pip-j7SJG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:36 INFO - Running setup.py (path:/tmp/pip-JO5kho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:36 INFO - Running setup.py (path:/tmp/pip-AK7pRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:36 INFO - Running setup.py (path:/tmp/pip-35i5sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:36 INFO - Running setup.py (path:/tmp/pip-zUihIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:36 INFO - Running setup.py (path:/tmp/pip-oxOcd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:36 INFO - Running setup.py (path:/tmp/pip-ZoXFKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:36 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)) 22:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:36 INFO - Running setup.py (path:/tmp/pip-wKT2mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:37 INFO - Running setup.py (path:/tmp/pip-uXxbH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:37 INFO - Running setup.py (path:/tmp/pip-D5jEPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:37 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)) 22:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:37 INFO - Running setup.py (path:/tmp/pip-hXqr9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:37 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)) 22:00:37 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)) 22:00:37 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)) 22:00:37 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)) 22:00:37 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)) 22:00:37 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)) 22:00:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:39 INFO - Downloading blessings-1.6.tar.gz 22:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:39 INFO - Installing collected packages: blessings 22:00:39 INFO - Running setup.py install for blessings 22:00:39 INFO - Successfully installed blessings 22:00:39 INFO - Cleaning up... 22:00:39 INFO - Return code: 0 22:00:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:39 INFO - Reading from file tmpfile_stdout 22:00:39 INFO - Current package versions: 22:00:39 INFO - argparse == 1.2.1 22:00:39 INFO - blessings == 1.6 22:00:39 INFO - blobuploader == 1.2.4 22:00:39 INFO - docopt == 0.6.1 22:00:39 INFO - functools32 == 3.2.3-2 22:00:39 INFO - jsonschema == 2.5.1 22:00:39 INFO - manifestparser == 1.1 22:00:39 INFO - mozInstall == 1.12 22:00:39 INFO - mozcrash == 0.17 22:00:39 INFO - mozdebug == 0.1 22:00:39 INFO - mozdevice == 0.48 22:00:39 INFO - mozfile == 1.2 22:00:39 INFO - mozhttpd == 0.7 22:00:39 INFO - mozinfo == 0.9 22:00:39 INFO - mozleak == 0.1 22:00:39 INFO - mozlog == 3.4 22:00:39 INFO - moznetwork == 0.27 22:00:39 INFO - mozprocess == 0.23 22:00:39 INFO - mozprofile == 0.28 22:00:39 INFO - mozrunner == 6.12 22:00:39 INFO - mozscreenshot == 0.1 22:00:39 INFO - mozsystemmonitor == 0.3 22:00:39 INFO - moztest == 0.7 22:00:39 INFO - mozversion == 1.4 22:00:39 INFO - psutil == 3.1.1 22:00:39 INFO - requests == 1.2.3 22:00:39 INFO - wsgiref == 0.1.2 22:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:39 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 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:39 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 22:00:39 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 22:00:39 INFO - Using env: {'DISPLAY': ':0', 22:00:39 INFO - 'HOME': '/home/cltbld', 22:00:39 INFO - 'LANG': 'en_US.UTF-8', 22:00:39 INFO - 'LANGUAGE': 'en_US:en', 22:00:39 INFO - 'LOGNAME': 'cltbld', 22:00:39 INFO - 'MAIL': '/var/mail/cltbld', 22:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:39 INFO - 'MOZ_NO_REMOTE': '1', 22:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:39 INFO - 'NO_EM_RESTART': '1', 22:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:39 INFO - 'PWD': '/builds/slave/test', 22:00:39 INFO - 'SHELL': '/bin/bash', 22:00:39 INFO - 'SHLVL': '1', 22:00:39 INFO - 'TERM': 'linux', 22:00:39 INFO - 'TMOUT': '86400', 22:00:39 INFO - 'USER': 'cltbld', 22:00:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:39 INFO - '_': '/tools/buildbot/bin/python'} 22:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 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)) 22:00:39 INFO - Cleaning up... 22:00:39 INFO - Return code: 0 22:00:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f193d711f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00: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'] in /builds/slave/test/build 22:00: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 22:00:39 INFO - Using env: {'DISPLAY': ':0', 22:00:39 INFO - 'HOME': '/home/cltbld', 22:00:39 INFO - 'LANG': 'en_US.UTF-8', 22:00:39 INFO - 'LANGUAGE': 'en_US:en', 22:00:39 INFO - 'LOGNAME': 'cltbld', 22:00:39 INFO - 'MAIL': '/var/mail/cltbld', 22:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:39 INFO - 'MOZ_NO_REMOTE': '1', 22:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:39 INFO - 'NO_EM_RESTART': '1', 22:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:39 INFO - 'PWD': '/builds/slave/test', 22:00:39 INFO - 'SHELL': '/bin/bash', 22:00:39 INFO - 'SHLVL': '1', 22:00:39 INFO - 'TERM': 'linux', 22:00:39 INFO - 'TMOUT': '86400', 22:00:39 INFO - 'USER': 'cltbld', 22:00:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:39 INFO - '_': '/tools/buildbot/bin/python'} 22:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:40 INFO - Cleaning up... 22:00:40 INFO - Return code: 0 22:00:40 INFO - Running post-action listener: _resource_record_post_action 22:00:40 INFO - Running post-action listener: _start_resource_monitoring 22:00:40 INFO - Starting resource monitoring. 22:00:40 INFO - [mozharness: 2016-10-14 05:00:40.099391Z] Finished create-virtualenv step (success) 22:00:40 INFO - [mozharness: 2016-10-14 05:00:40.099842Z] Running install step. 22:00:40 INFO - Running pre-action listener: _resource_record_pre_action 22:00:40 INFO - Running main action method: install 22:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:40 INFO - Reading from file tmpfile_stdout 22:00:40 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:40 INFO - Reading from file tmpfile_stdout 22:00:40 INFO - Output received: 22:00:40 INFO - Usage: mozinstall [options] installer 22:00:40 INFO - Options: 22:00:40 INFO - -h, --help show this help message and exit 22:00:40 INFO - -d DEST, --destination=DEST 22:00:40 INFO - Directory to install application into. [default: 22:00:40 INFO - "/builds/slave/test"] 22:00:40 INFO - --app=APP Application being installed. [default: firefox] 22:00:40 INFO - mkdir: /builds/slave/test/build/application 22:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:00:56 INFO - Reading from file tmpfile_stdout 22:00:56 INFO - Output received: 22:00:56 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:56 INFO - Running post-action listener: _resource_record_post_action 22:00:56 INFO - [mozharness: 2016-10-14 05:00:56.386881Z] Finished install step (success) 22:00:56 INFO - [mozharness: 2016-10-14 05:00:56.387126Z] Running run-tests step. 22:00:56 INFO - Running pre-action listener: _resource_record_pre_action 22:00:56 INFO - Running main action method: run_tests 22:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:56 INFO - Python 2.7.3 22:00:56 INFO - Return code: 0 22:00:56 INFO - grabbing minidump binary from tooltool 22:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:56 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/linux64/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 0x21d1f60>, '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 0x21d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:56 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:00:56 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/linux64/releng.manifest -o -c /builds/tooltool_cache 22:00:56 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:00:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:56 INFO - Return code: 0 22:00:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:00:56 INFO - Using env: {'DISPLAY': ':0', 22:00:56 INFO - 'HOME': '/home/cltbld', 22:00:56 INFO - 'LANG': 'en_US.UTF-8', 22:00:56 INFO - 'LANGUAGE': 'en_US:en', 22:00:56 INFO - 'LOGNAME': 'cltbld', 22:00:56 INFO - 'MAIL': '/var/mail/cltbld', 22:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:56 INFO - 'MOZ_NO_REMOTE': '1', 22:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:56 INFO - 'NO_EM_RESTART': '1', 22:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:56 INFO - 'PWD': '/builds/slave/test', 22:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:56 INFO - 'SHELL': '/bin/bash', 22:00:56 INFO - 'SHLVL': '1', 22:00:56 INFO - 'TERM': 'linux', 22:00:56 INFO - 'TMOUT': '86400', 22:00:56 INFO - 'USER': 'cltbld', 22:00:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217', 22:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:56 INFO - '_': '/tools/buildbot/bin/python'} 22:00:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:00:56 INFO - mozversion application_buildid: 20161013190536 22:00:56 INFO - mozversion application_changeset: 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c 22:00:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:00:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:56 INFO - mozversion application_name: Firefox 22:00:56 INFO - mozversion application_remotingname: firefox-dev 22:00:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:00:56 INFO - mozversion application_vendor: Mozilla 22:00:56 INFO - mozversion application_version: 51.0a2 22:00:56 INFO - mozversion platform_buildid: 20161013190536 22:00:56 INFO - mozversion platform_changeset: 47f70e2af768c0a48ac6c938a1cf89f1e9d1138c 22:00:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:00:56 INFO - mozversion platform_version: 51.0a2 22:00:56 INFO - using testdate: 1476421256 22:00:56 INFO - actual date: 1476421256 22:00:56 INFO - starting webserver on 'localhost:33476' 22:00:56 INFO - SUITE-START | Running 2 tests 22:00:56 INFO - TEST-START | dromaeo_css 22:00:56 INFO - operating with platform_type : linux_ 22:00:56 INFO - Initialising browser for dromaeo_css test... 22:00:56 INFO - TEST-INFO | started process 17892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjwaQXq/profile http://localhost:33476/getInfo.html) 22:01:00 INFO - PROCESS | 17892 | __metrics Screen width/height:1600/1200 22:01:00 INFO - PROCESS | 17892 | colorDepth:24 22:01:00 INFO - PROCESS | 17892 | Browser inner width/height: 1024/697 22:01:00 INFO - PROCESS | 17892 | __metrics 22:01:01 INFO - PROCESS | 17892 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:01:01 INFO - PROCESS | 17892 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:01 INFO - PROCESS | 17892 | console.error: PushService: 22:01:01 INFO - PROCESS | 17892 | stateChangeProcessEnqueue: Error transitioning state 22:01:01 INFO - PROCESS | 17892 | UnknownError 22:01:02 INFO - TEST-INFO | 17892: exit 0 22:01:02 INFO - Browser initialized. 22:01:02 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:02 INFO - TEST-INFO | started process 17985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjwaQXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:13 INFO - PROCESS | 17985 | RSS: Main: 144871424 22:01:13 INFO - PROCESS | 17985 | 22:02:04 INFO - PROCESS | 17985 | 1476421324898 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] 22:04:13 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33476/tests/dromaeo/cssquery-ext.html) 22:04:14 INFO - PROCESS | 17985 | RSS: Main: 242364416 22:04:14 INFO - PROCESS | 17985 | 22:07:17 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-ext.html (next: http://localhost:33476/tests/dromaeo/cssquery-jquery.html) 22:07:17 INFO - PROCESS | 17985 | RSS: Main: 231911424 22:07:17 INFO - PROCESS | 17985 | 22:10:19 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33476/tests/dromaeo/cssquery-mootools.html) 22:10:20 INFO - PROCESS | 17985 | RSS: Main: 218836992 22:10:20 INFO - PROCESS | 17985 | 22:13:22 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33476/tests/dromaeo/cssquery-prototype.html) 22:13:22 INFO - PROCESS | 17985 | RSS: Main: 173891584 22:13:22 INFO - PROCESS | 17985 | 22:16:25 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33476/tests/dromaeo/cssquery-yui.html) 22:16:26 INFO - PROCESS | 17985 | RSS: Main: 177184768 22:16:26 INFO - PROCESS | 17985 | 22:19:28 INFO - PROCESS | 17985 | Cycle 1(1): loaded http://localhost:33476/tests/dromaeo/cssquery-yui.html (next: http://localhost:33476/tests/dromaeo/cssquery-dojo.html) 22:19:29 INFO - PROCESS | 17985 | RSS: Main: 265838592 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | __start_tp_report 22:19:29 INFO - PROCESS | 17985 | _x_x_mozilla_page_load 22:19:29 INFO - PROCESS | 17985 | _x_x_mozilla_page_load_details 22:19:29 INFO - PROCESS | 17985 | |i|pagename|runs| 22:19:29 INFO - PROCESS | 17985 | |0;dojo.html;3058.801177923435;3100.22494376406;3111.5799367085438;3120.8751649934;3143.0256620447662;5357.008953343634;5366.248725178473;5384.515393614574;5384.757685904134;5407.05376559102;5336.30628018358;5340.706261155635;5341.759620817063;5349.117395629726;5373.462653734625;4795.184818580849;4850.248211527201;4859.07677541266;4901.240307752304;4912.21404575268;4837.6129909607325;4879.243717223836;4970.105381031413;4979.551840334369;5000.4749501302385;4794.184988551954;4850.514948505156;4858.611311095104;4903.7302948338;4904.877378065541;4878.438979517347;4909.45995940448;4911.8280860169725;4957.058158949824;4990;4856.198727210006;4901.8774530636665;4903.4606193318705;4924.3105965164905;4928;5121.4110377306715;5199.558037566773;5213.7393130343335;5289.9471005290225;5314.787408503656;5601.5238704709745;5619.213310136584;5630.0991841305195;5676.063449530822;5694.886102277973;5730.19777231188;5737.827865164052;5743.856403589902;5750.79872204475;5756.769729210827;5146.665466744649;5180.689158650455;5296.92054619181;5330.040592693353;5335.9466405336225;5788.5369170466265;5806.82579522615;5809.4771470567;5809.680467574324;5819.73811178498;5617.747201375948;5621.381648018714;5623.943760562423;5625.887482250332;5629.634073785191;5587.916181257285;5636;5658.886822263532;5693.373728889819;5708.286464191976;5726.226959360516;5726.284214473191;5739.913901291484;5751.964646363611;5752.971235143881;5750.971245143831;5754.223179870748;5755.8561035974435;5760.654360738369;5778.046622307356;4294.420253265832;4369.148016136886;4390.978045109754;4436.112777444459;4485.372047913294;3971.0667993021616;3973.384125460558;3996.2606917720314;3997.080671445584;4016.116454380032;5366.141417373202;5395.082835917903;5403.2705584746345;5410.026195284808;5443.346798384219;5519.31008623922;5574.916376254359;5703.572232082611;5712.65724056558;5721.170430287585;5434.098065677061;5486.807961721401;5511.3937466878615;5521.806736764194;5553.305836770403;5068.341115654941;5073.746312684351;5076.796928122908;5077.796888124433;5109.105906466353;5793;5806.332271788714;6020.157177994996;6021.2473440819895;6022.638641681513;5628.690422026828;5647.943520564741;5673.631213971079;5706.9714651426475;5750.568707346882;5895.764169433346;5906;5911.852203694942;5912.260967378906;5914.319853216935;5502.779888804403;5557.110862262019;5618.634788738719;5619.662820230799;5626.746796394254;5631.239782629293;5674.517665998271;5698.230738850202;5754.56840736938;5761.395053519488;5610.943890561205;5622.7750889963945;5625.353084395347;5628.437156284339;5628.63413878113;5412.269343638558;5572;5603.439656034364;5619.100943848965;5633;5450.863728406663;5547.916781248366;5583.0787919992745;5590.105583106683;5675.716214189191;5648.689322087324;5674.886502270014;5678.914816277676;5680.488756011979;5689;5348.117560602457;5514.944850551443;5548.639338442988;5557.277553917965;5565.77736890536 22:19:29 INFO - PROCESS | 17985 | |1;ext.html;586.3960121075294;615.2954866677654;619.8109576579144;635.3773302163883;644.5005121031201;34418.65581344186;46877.76561117194;47691.76154119229;47780.2832957505;47831.760841195835;48581.27128093073;48599.27101093486;49055;49130;49189.262161067614;9401.388909720863;9560.474173920431;9564.091411315949;9566.043395660414;9568.904310956907;8519.57402129894;8744.038155802857;11086.445677716123;11361.943190284037;11374.203805733601;11457.197996140274;11458.255213411143;11539;11558.13314001449;11560.884391156107;8565.186307300859;11394.316341019525;11448.370339631318;11469.655910322663;11479.942600286988;8621.56892155396;10851.403172825492;11233.494492747846;11244.943775281072;11558.653240402802;44883.32675009845;45251.54748452539;45255.32117018214;45306.77346613246;45396;3555.768875023141;3612.313660404541;3617.403128483797;3631.7094632429344;3656.433252845813;35244.118897027525;35597.82201088978;35921.46117808235;36208.27583448316;36297.45553816695;4617.238155704338;4634.536546345338;4685.5314468553215;4715.528447155291;4718.669693121483;354475;356992;357482;358122;359202.20398898097;38058.80970595185;65927.67036164789;66286.33713662802;66423.33576664267;66460.33539664638;39443.21113577712;42034.579654203066;42089.78955105266;42092.579074209476;42156.15687686229;16555.751663725056;16700.83299167017;16756.162191890602;16761.832381676028;16765.077920714233;12715.872841271654;13183.14309569875;13321.533746319026;13432.395542200624;13436.1266517678;9339.719808405758;9625.229981601455;9635.22918166559;9680.757981050388;9770.413775173512;3630.8366123524506;3641.1079285574674;3684.2078953024693;3688.5758137814496;3716.851325946986;976.5703090640237;995.5719040812376;1002.9097381235724;1010.7271036820017;1145.2040831621944;33583.16042098918;33849.492257616155;34172.66724803787;34177.829110854786;34220.65779342175;1051.6371851711147;1114.4483480676954;1173.1260211142753;1179.988200118005;1225.9632211033684;17739.467815965283;17778.644427111645;17781;17976.101194940464;18049.09754512269;630158;637277;637349;639602;641102;63617.681911590145;63716.68141659262;64097;64149;64222;1307.4704744578462;1367.5623800383783;1377.15993244121;1398.3427788939182;1401.068289587413;32428.513572296906;35010.82494587511;35032.474512882836;35037;35166.29667406587;54247.72876135594;54855.451445485036;54893.451065488836;54932.72533637306;54971;396828;400030;400094;400469;401055;30502.847485763315;31664.208394790316;31743.841280793447;32481.187970299987;32577.534010969088;51635;51681;51769.22346164886;51855.481445186575;52920;43437.782811085744;44255.77872110619;44341.55658443374;44531.55468445404;45812.54187458216;43060.35409468798;43669;44150;45266.0946781056;45316.54683453255;41221;44046;45027;45574.08851823011;45690.54309456863;36155.81922090373;39221.41167882541;39393;39424.605753942094;40469.39295910505;29449.411011779215;29773;30001.399972000003;30203;30520.694793051785 22:19:29 INFO - PROCESS | 17985 | |2;jquery.html;387.84486205517806;409.8770368889332;412.26822390257297;422.69777109366794;424.27449062103807;14566.854331456681;16405.75391369129;20033.699494507575;20778.792212077875;20968.26611068613;16353.182340882939;16693.9983600984;16695.749563756523;19755.802441975575;20316.288929887458;5302.3106996090555;5455.672659640434;5465.234867118606;5512.972435137819;6173.629582225081;4024.859129930453;6118.388161183891;6164.938350616504;6208.037754148114;6209.689515524228;4203.096334288128;5672.262605861232;5943.167956486074;5993.550483713717;6062.666553339564;5965.642061476326;5966.582339236255;6001.429864162941;6032.366601506845;6042.063480160582;5720.2849643794525;5847.736851841635;5848.67832269225;5853.678047707374;5854.151148083504;13134.605961821066;14155.787663184958;22474.887625561933;23393.883030584908;23494;2367.5838477725383;2494.8627825469594;2515.5220508103403;2539.441322908957;2926.4732348177317;9889.406635601816;10176.084152426318;15003.274623418338;15921.840781592151;15952.122633255167;1793.7309403589436;1840.1167439629053;1842.106578309519;1854.9907250463796;1905.4474202481265;80318;81525;83227.5838620803;87519;88559.55720221357;11589.478473468715;11665.125115616363;11718.414079296;11793.29240245588;12068.405292862077;16670.83329166717;16671.49985500437;16693.081880496447;16705.749413758804;16708.832911670972;8330.50016998982;8491;8504.064552899175;8538.87191692125;8611;7887.132415434297;7914.366850651934;8068.515889046676;8100.108988011314;8188.099309075997;4910.607151427877;4982.427020892644;5028.472010438852;5059.468755780664;5116.488351164928;1932.420273917819;2054.9280775172797;2076.1487790006026;2084.7185629939763;2099.139352865318;777.4752042371376;923.1783712495884;940.6754669638964;970.7476056225291;983.188869182927;20056.59886802285;20603.484912876997;20633.48416289605;20651.58696826055;20732.896335518526;991.6975322526555;1017.7048655889857;1044.8223801953686;1083.7290677330668;1091.0398849012818;11008.504617292241;11216.607418740468;11327;11354.205205635526;11490.850914908442;487377;495738;495905;499639;510656;67976.6601166991;73839.63080184565;96790.03209967811;98908;103210.48394758128;1003.4681618742078;1042.0985847242082;1043.2905624175633;1062.8671416072991;1063.2079101069753;17658.76388652782;17925.641487169923;18209.45371638853;18215.089245537405;18455;44866.77566612146;45202.77398612986;45358.319625206306;46318.76840615775;46528.06943861172;60990.39009609847;61787;62851.685741571;62957.37042629515;62994.685026574574;8142.145074767301;8281.668733250603;8395.202455766692;8604.440711353742;8708.129187081242;9777.560009799718;13168.47326106945;13248.867511324763;13402;13618.659533511345;11433;11440.42797860087;11693.356865372487;11861.881381186078;12255.080868934687;11303.265287756269;11424.428778560872;11594.71013224676;11818.113641477095;12350.44423000949;11762.76474470523;11852.525898963944;12127.454264558293;12216.75566488683;12386.876131238932;7275.1997280298065;7654.540727556365;8263.091059983517;8396.706115285935;8631.093735157969;10682.946585267024;10896.528968589138;11489.253198542068;11517.366544840113;11775.411229438665 22:19:29 INFO - PROCESS | 17985 | |3;mootools.html;1492.641765976166;1524.7484165112755;1637.328695234954;1742.3640371264491;1799.541117015161;7950.76147715568;8491.575421228945;8494.320454363644;8495.872561911568;8498.107698691641;7447;7693.269139431759;7707.1522132565515;7946.404019698517;8173.632186551605;2349.69453970984;2376.144587948337;2378.988105059472;2379.8334116611845;2381.8570885746826;2314.8611083335054;2321.292005938188;2358.469344397514;2359.4691194481275;2363.82271329651;2062.845286603503;2131.0942849289067;2269.704938358011;2343.53129374125;2347.4248809041724;2296.2881506732965;2314.5370925814905;2318.026428899866;2318.7913087822008;2321.373229228099;2321.3500219938273;2322.9651555226687;2327.4995875886766;2328.2782337475437;2329.6621989811383;8372.28835548979;8431.536265505394;8438.240558349778;8448.197421244971;8448.78878028048;4862.489438608931;4888.853334399973;4951.282064100686;4952.380952380952;4956.826511072095;3277.2626159114006;3287.3260981498734;3391;3408.5057666638445;3410.454327307644;1216.574199030341;1220.725336799213;1250.1686378558247;1259.439549400517;1269.8158766978736;11183.720406989809;11267.718307042389;11271.830922536168;11297.943510282477;11301.321920684784;4182.895427614334;4225.640820530228;4373.475182978063;4382.364557139197;4452.621527170227;9710.126088652056;9712.75718107053;9714.125728684452;9714.659986900424;9717.514124293899;5014.7994080236385;5016.0971025215085;5019.799208031638;5021.5229553192385;5068.873278168076;4551.977240113778;4635.397398338195;4639.257718764981;4646.233371493666;4711.45818230901;3936.8622098226424;3976.980115099406;4043.211573743092;4074.4295798588223;4181.247375472444;1157.5196293538088;1253.7053792358788;1298.5909438526835;1309.7118633900527;1312.2454588611586;838.2204549768774;853.6030745703277;926.9710621210451;1014.9644762433279;1017.995826910986;5760.798372056958;5808.303003639506;5841.561882858802;5856.736446859902;5919.704014799243;984.7390441532999;1013.3058854684417;1017.1049476460668;1027.106417416852;1064.6539874540806;3926;4120.855770048034;4150.190712810973;4164.479440069991;4207.200631879933;9534.666286679932;9902.356346837432;9974.650887218913;10448;10449.373037617766;10226.130778883879;10232.02795734404;10236.283460157718;10240.539175737109;10241.48792560369;7767.922320776833;7775.805604859924;7859.214078592095;7878.172791856887;7922.168172341821;5644.379118296902;5738.22533957927;5868.149118377726;5885.882282354243;6055.3944605540855;9425;9485.288603354638;9536.856947145938;9571.521423928636;9582.28132890022;8948.86576701363;9451.810963780548;9458.858117128111;9556.569954351931;9713.854292185764;7343.963280183779;7481.925180748341;7505.286997735207;7511.211322811027;7512.812179695551;8146.75559733209;8205.179482051986;8209.917900820916;8215.301699355621;8218.21926916942;7057.788266352018;7141.214466408795;7173.856522869618;7185.173705023989;7285.162206346126;7288.562686238843;7334.816629584089;7366.152892417441;7414.962925185339;7423.628818559158;6594.208694956636;6632.071509988509;6694;6735.191776986793;6764.4588432924265;4985.351904252424;5030.572401345927;5051.696898186121;5093.363329583802;5145.382554093533;4951.801927922987;5039.899202016012;5216.426193118678;5231.843044708665;5316.989771943318 22:19:29 INFO - PROCESS | 17985 | |4;prototype.html;314.81897908702496;316.6184747379408;319.3533095481649;320.5736370627066;322.2057627947111;5521.668699878005;5525.889482210358;5533.723313834313;5539.750711217995;5540.612157148991;5457.2359869618285;5466.371367292762;5470.206820011096;5476.123820188771;5516.255305533752;4017.919641607181;4084.4281800547874;4195.265828480004;4206.789660516962;4241.618254357108;4222.387753775701;4231.70378073535;4262.318029115342;4268.6798490113215;4268.807903644328;4173.812178451962;4183.372494125891;4184.456020717303;4187.350960601112;4204.8738537843765;4053.6149065838845;4201.852935147271;4205.453291072141;4210.978945105286;4211.663066954637;3710.703143748494;3714.9226724249934;3728.179800443898;3732.962670373289;3735.402335626287;5367.677939323653;5392.40683524812;5392.730363481849;5397.436217796554;5415.756290966877;4609.193391156534;4761.6904901181315;4830.975845120752;4867.51324867514;4877.780499877514;5642.746076426571;5664.291963504562;5697.353693636076;5711.371749107595;5730.885382292331;4006.238814625212;4025.9798701006603;4032.810320955296;4052.817623206933;4072.450219220397;5905.6751878646655;5950.363649996286;5961.761529538813;5989;6028.336882942873;4090.8363665453644;4103.322951712994;4106.07613287008;4109.465769450012;4112.91774164515;4154.127633197002;4161.25097482456;4162.41726158338;4171.457710497616;4172.520160181618;4681.555252251031;4767.141914455431;4810.63920205986;4814.15752243356;4826.8793280168275;5737.356778445634;5749.770009199585;5752.913706294409;5758.395368486333;5770.365259821417;1413.0814970269203;1437.2598111972343;1439.5753252790453;1441.207335965215;1445.3640398224748;900.257287737606;911.1389736698756;916.2944532709777;925.7916968681992;929.1266209762802;5515.227868098469;5543.2793736814765;5563.276774019351;5573.359063707644;5604.579656525777;5852.239208902901;5858.677772722456;5874.647521148745;5876.324222714357;5886.8822623547285;5324.494173053554;5518.889622207534;5573.944260557424;5593.958205255052;5659.575531835047;3121.781475296753;3126.6716994715684;3134.0754477429214;3147.630780610442;3153.7227422893766;5904.261967254093;6097.207363042776;6116.938830611726;6131.294901086432;6152.630842149485;6106.511479081662;6145.139680444741;6151.784687536005;6153.907691384633;6159.6612186329285;6164;6198.845028874224;6203.875922481525;6213.813585592439;6222.906656400158;5696.231008813757;5879.029960056543;5953.523718102455;5971.193888825127;5991.370906054975;5874.265716785402;5904.143899134688;5916.881662366643;5944.554158438048;5949.583529152917;5893.616914900518;6149;6168.8766224674355;6186.350433204629;6197.5351848610635;4190.958090419057;4212.91574168521;4221.577842215754;4250.341197114452;4252.659787217077;6060.90908636362;6068.271807383142;6078.6048906820915;6100.511959043177;6111.716539526749;5686.2607860977805;5785.768569257182;5835.066389377679;5837.562182836219;5975.731092100779;5817.76728930838;5825.300963884361;5825.94174058254;5833.883322333614;5843.649381037151;5586.888262234814;5801.680907550125;5809.82570522885;5863.794767183128;5889.411058894248;5778.711064446845;5813.709314534341;5827.388124246893;5845.240118784531;5868.2664666916635;5705.201271822031;5719.8570035749435;5743.56923230751;5746.942530574641;5752.568557358299 22:19:29 INFO - PROCESS | 17985 | |5;yui.html;812.991870081299;818.0592318833341;866.9219770220678;875.851105312097;887.6493784954945;15494.38022479101;15627.374905003815;15739.449119280798;15749.291281892314;15762.92118539407;14810.777838332433;14830.332635031422;14899.85100149001;14935.17856517891;14943.252837358115;711.3171355498714;730.2879692300019;731.4221764805797;732.0264048815063;843.439112989861;841.6507149532968;841.8400503904269;849.4308813095241;849.9447535910177;851.0425771007616;904.4799240436743;914.9980771055716;915.0666320353236;915.0940568836837;915.1443400420628;905.2034209895315;909.1408618855185;909.8908131024286;910.1899309614415;910.6539514984297;550.1060776238612;561.8089849451165;650.7136859781681;671.493022767812;676.3980057748607;13237.073404861663;13744;13758.793618095737;13759.10565813219;13768.724625507533;14196.929015354961;14294.571162865132;14461.71076578473;14722.705545889023;15018.324175412132;13315.684845600532;13397.330133493384;13489.595312140651;13525.526606568723;13847.307634618228;4629.652776041777;4674.7428891410955;4733.692309999839;4923.089228492705;4927.950720492785;88408.55795721045;88613;89835;90112.54943725305;90237;11887.762244755057;11997.340146291863;12061.336626485452;12171.634850954486;12271.141020128505;24234.757652423603;24237.878810605835;24271.514569708506;24272;24298.271051868473;8159.632816523271;8203.097659257477;8239.340852731768;8409.789755256044;8455.408121431441;4423.867283981485;4545.0909818036525;4596.37948876904;4618.56123668251;4769.928451073237;3278.950815737766;3342.495876855376;3372.629010808809;3372.9494057589154;3379.732600274897;562.3139769481227;567.4637467593168;574.7097715653651;579.6000759475949;581.1515187825737;579.3569138256532;654.9901751473732;674.6390680985747;677.3801971196399;705.7353492440335;9696.17582505495;9882.950585247028;10376.792464150674;10471.633492827714;10639.14886809069;632.5761739634456;641.6791604197902;675.2774531251612;675.4866301610713;682.8327059870363;4968.72672003036;5038.924416133761;5095.770690318945;5102.311187989648;5127.3847138343635;121202.39398803125;129507;129636;132555;138364;111951;116242;119706.40146799211;120026.39986800184;121146.39426802809;98969.50515247378;100680;101482.49258753807;103530;104132.47933760282;9134.314926380415;9391.812163756824;9498.19265362452;10098;10161.390316581028;52566.73716631392;53116.2032569504;55021;55139.17291240715;55664.72167639136;78535;80012.59993699995;80015;81825.59087204526;82914;11681.707957301136;11704.70738231517;11809.23239989398;12025.218360806519;12286.692832679255;12971;13664.769612582384;13793.586192414243;13818.585442436743;13849.307534623431;12245.510179592717;12445.564405245774;12453.128281020605;12885.7623034937;13041.804372934603;12645.304508252135;12785.232886026868;12978.675533111747;13129.474821007052;13286.734265314833;12758.48966041385;13198.670033249246;13497.932510337385;13526.39131239077;13548.525801596898;9167.220786233245;9676.95161524216;9719.514024298614;9943.950280248553;10009.499525023866;10322.066008575192;10366.429846358522;10878.673639790502;11085.168612354268;11222.943885280521 22:19:29 INFO - PROCESS | 17985 | __end_tp_report 22:19:29 INFO - PROCESS | 17985 | __start_cc_report 22:19:29 INFO - PROCESS | 17985 | _x_x_mozilla_cycle_collect,895 22:19:29 INFO - PROCESS | 17985 | __end_cc_report 22:19:29 INFO - PROCESS | 17985 | __startTimestamp1476422369000__endTimestamp 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | ------- Summary: start ------- 22:19:29 INFO - PROCESS | 17985 | Number of tests: 6 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#0] dojo.html Cycles:165 Average:5319.99 Median:5553.31 stddev:585.73 (10.5%) stddev-sans-first:560.02 22:19:29 INFO - PROCESS | 17985 | Values: 3058.8 3100.2 3111.6 3120.9 3143.0 5357.0 5366.2 5384.5 5384.8 5407.1 5336.3 5340.7 5341.8 5349.1 5373.5 4795.2 4850.2 4859.1 4901.2 4912.2 4837.6 4879.2 4970.1 4979.6 5000.5 4794.2 4850.5 4858.6 4903.7 4904.9 4878.4 4909.5 4911.8 4957.1 4990.0 4856.2 4901.9 4903.5 4924.3 4928.0 5121.4 5199.6 5213.7 5289.9 5314.8 5601.5 5619.2 5630.1 5676.1 5694.9 5730.2 5737.8 5743.9 5750.8 5756.8 5146.7 5180.7 5296.9 5330.0 5335.9 5788.5 5806.8 5809.5 5809.7 5819.7 5617.7 5621.4 5623.9 5625.9 5629.6 5587.9 5636.0 5658.9 5693.4 5708.3 5726.2 5726.3 5739.9 5752.0 5753.0 5751.0 5754.2 5755.9 5760.7 5778.0 4294.4 4369.1 4391.0 4436.1 4485.4 3971.1 3973.4 3996.3 3997.1 4016.1 5366.1 5395.1 5403.3 5410.0 5443.3 5519.3 5574.9 5703.6 5712.7 5721.2 5434.1 5486.8 5511.4 5521.8 5553.3 5068.3 5073.7 5076.8 5077.8 5109.1 5793.0 5806.3 6020.2 6021.2 6022.6 5628.7 5647.9 5673.6 5707.0 5750.6 5895.8 5906.0 5911.9 5912.3 5914.3 5502.8 5557.1 5618.6 5619.7 5626.7 5631.2 5674.5 5698.2 5754.6 5761.4 5610.9 5622.8 5625.4 5628.4 5628.6 5412.3 5572.0 5603.4 5619.1 5633.0 5450.9 5547.9 5583.1 5590.1 5675.7 5648.7 5674.9 5678.9 5680.5 5689.0 5348.1 5514.9 5548.6 5557.3 5565.8 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#1] ext.html Cycles:180 Average:63070.99 Median:218135.61 stddev:127979.17 (58.7%) stddev-sans-first:128252.19 22:19:29 INFO - PROCESS | 17985 | Values: 586.4 615.3 619.8 635.4 644.5 34418.7 46877.8 47691.8 47780.3 47831.8 48581.3 48599.3 49055.0 49130.0 49189.3 9401.4 9560.5 9564.1 9566.0 9568.9 8519.6 8744.0 11086.4 11361.9 11374.2 11457.2 11458.3 11539.0 11558.1 11560.9 8565.2 11394.3 11448.4 11469.7 11479.9 8621.6 10851.4 11233.5 11244.9 11558.7 44883.3 45251.5 45255.3 45306.8 45396.0 3555.8 3612.3 3617.4 3631.7 3656.4 35244.1 35597.8 35921.5 36208.3 36297.5 4617.2 4634.5 4685.5 4715.5 4718.7 354475.0 356992.0 357482.0 358122.0 359202.2 38058.8 65927.7 66286.3 66423.3 66460.3 39443.2 42034.6 42089.8 42092.6 42156.2 16555.8 16700.8 16756.2 16761.8 16765.1 12715.9 13183.1 13321.5 13432.4 13436.1 9339.7 9625.2 9635.2 9680.8 9770.4 3630.8 3641.1 3684.2 3688.6 3716.9 976.6 995.6 1002.9 1010.7 1145.2 33583.2 33849.5 34172.7 34177.8 34220.7 1051.6 1114.4 1173.1 1180.0 1226.0 17739.5 17778.6 17781.0 17976.1 18049.1 630158.0 637277.0 637349.0 639602.0 641102.0 63617.7 63716.7 64097.0 64149.0 64222.0 1307.5 1367.6 1377.2 1398.3 1401.1 32428.5 35010.8 35032.5 35037.0 35166.3 54247.7 54855.5 54893.5 54932.7 54971.0 396828.0 400030.0 400094.0 400469.0 401055.0 30502.8 31664.2 31743.8 32481.2 32577.5 51635.0 51681.0 51769.2 51855.5 52920.0 43437.8 44255.8 44341.6 44531.6 45812.5 43060.4 43669.0 44150.0 45266.1 45316.5 41221.0 44046.0 45027.0 45574.1 45690.5 36155.8 39221.4 39393.0 39424.6 40469.4 29449.4 29773.0 30001.4 30203.0 30520.7 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#2] jquery.html Cycles:180 Average:29496.01 Median:2527.48 stddev:82115.41 (3248.9%) stddev-sans-first:82316.68 22:19:29 INFO - PROCESS | 17985 | Values: 387.8 409.9 412.3 422.7 424.3 14566.9 16405.8 20033.7 20778.8 20968.3 16353.2 16694.0 16695.7 19755.8 20316.3 5302.3 5455.7 5465.2 5513.0 6173.6 4024.9 6118.4 6164.9 6208.0 6209.7 4203.1 5672.3 5943.2 5993.6 6062.7 5965.6 5966.6 6001.4 6032.4 6042.1 5720.3 5847.7 5848.7 5853.7 5854.2 13134.6 14155.8 22474.9 23393.9 23494.0 2367.6 2494.9 2515.5 2539.4 2926.5 9889.4 10176.1 15003.3 15921.8 15952.1 1793.7 1840.1 1842.1 1855.0 1905.4 80318.0 81525.0 83227.6 87519.0 88559.6 11589.5 11665.1 11718.4 11793.3 12068.4 16670.8 16671.5 16693.1 16705.7 16708.8 8330.5 8491.0 8504.1 8538.9 8611.0 7887.1 7914.4 8068.5 8100.1 8188.1 4910.6 4982.4 5028.5 5059.5 5116.5 1932.4 2054.9 2076.1 2084.7 2099.1 777.5 923.2 940.7 970.7 983.2 20056.6 20603.5 20633.5 20651.6 20732.9 991.7 1017.7 1044.8 1083.7 1091.0 11008.5 11216.6 11327.0 11354.2 11490.9 487377.0 495738.0 495905.0 499639.0 510656.0 67976.7 73839.6 96790.0 98908.0 103210.5 1003.5 1042.1 1043.3 1062.9 1063.2 17658.8 17925.6 18209.5 18215.1 18455.0 44866.8 45202.8 45358.3 46318.8 46528.1 60990.4 61787.0 62851.7 62957.4 62994.7 8142.1 8281.7 8395.2 8604.4 8708.1 9777.6 13168.5 13248.9 13402.0 13618.7 11433.0 11440.4 11693.4 11861.9 12255.1 11303.3 11424.4 11594.7 11818.1 12350.4 11762.8 11852.5 12127.5 12216.8 12386.9 7275.2 7654.5 8263.1 8396.7 8631.1 10682.9 10896.5 11489.3 11517.4 11775.4 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#3] mootools.html Cycles:180 Average:5543.25 Median:5015.45 stddev:3022.54 (60.3%) stddev-sans-first:3015.69 22:19:29 INFO - PROCESS | 17985 | Values: 1492.6 1524.7 1637.3 1742.4 1799.5 7950.8 8491.6 8494.3 8495.9 8498.1 7447.0 7693.3 7707.2 7946.4 8173.6 2349.7 2376.1 2379.0 2379.8 2381.9 2314.9 2321.3 2358.5 2359.5 2363.8 2062.8 2131.1 2269.7 2343.5 2347.4 2296.3 2314.5 2318.0 2318.8 2321.4 2321.4 2323.0 2327.5 2328.3 2329.7 8372.3 8431.5 8438.2 8448.2 8448.8 4862.5 4888.9 4951.3 4952.4 4956.8 3277.3 3287.3 3391.0 3408.5 3410.5 1216.6 1220.7 1250.2 1259.4 1269.8 11183.7 11267.7 11271.8 11297.9 11301.3 4182.9 4225.6 4373.5 4382.4 4452.6 9710.1 9712.8 9714.1 9714.7 9717.5 5014.8 5016.1 5019.8 5021.5 5068.9 4552.0 4635.4 4639.3 4646.2 4711.5 3936.9 3977.0 4043.2 4074.4 4181.2 1157.5 1253.7 1298.6 1309.7 1312.2 838.2 853.6 927.0 1015.0 1018.0 5760.8 5808.3 5841.6 5856.7 5919.7 984.7 1013.3 1017.1 1027.1 1064.7 3926.0 4120.9 4150.2 4164.5 4207.2 9534.7 9902.4 9974.7 10448.0 10449.4 10226.1 10232.0 10236.3 10240.5 10241.5 7767.9 7775.8 7859.2 7878.2 7922.2 5644.4 5738.2 5868.1 5885.9 6055.4 9425.0 9485.3 9536.9 9571.5 9582.3 8948.9 9451.8 9458.9 9556.6 9713.9 7344.0 7481.9 7505.3 7511.2 7512.8 8146.8 8205.2 8209.9 8215.3 8218.2 7057.8 7141.2 7173.9 7185.2 7285.2 7288.6 7334.8 7366.2 7415.0 7423.6 6594.2 6632.1 6694.0 6735.2 6764.5 4985.4 5030.6 5051.7 5093.4 5145.4 4951.8 5039.9 5216.4 5231.8 5317.0 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#4] prototype.html Cycles:180 Average:4850.61 Median:5573.65 stddev:1463.13 (26.3%) stddev-sans-first:1427.08 22:19:29 INFO - PROCESS | 17985 | Values: 314.8 316.6 319.4 320.6 322.2 5521.7 5525.9 5533.7 5539.8 5540.6 5457.2 5466.4 5470.2 5476.1 5516.3 4017.9 4084.4 4195.3 4206.8 4241.6 4222.4 4231.7 4262.3 4268.7 4268.8 4173.8 4183.4 4184.5 4187.4 4204.9 4053.6 4201.9 4205.5 4211.0 4211.7 3710.7 3714.9 3728.2 3733.0 3735.4 5367.7 5392.4 5392.7 5397.4 5415.8 4609.2 4761.7 4831.0 4867.5 4877.8 5642.7 5664.3 5697.4 5711.4 5730.9 4006.2 4026.0 4032.8 4052.8 4072.5 5905.7 5950.4 5961.8 5989.0 6028.3 4090.8 4103.3 4106.1 4109.5 4112.9 4154.1 4161.3 4162.4 4171.5 4172.5 4681.6 4767.1 4810.6 4814.2 4826.9 5737.4 5749.8 5752.9 5758.4 5770.4 1413.1 1437.3 1439.6 1441.2 1445.4 900.3 911.1 916.3 925.8 929.1 5515.2 5543.3 5563.3 5573.4 5604.6 5852.2 5858.7 5874.6 5876.3 5886.9 5324.5 5518.9 5573.9 5594.0 5659.6 3121.8 3126.7 3134.1 3147.6 3153.7 5904.3 6097.2 6116.9 6131.3 6152.6 6106.5 6145.1 6151.8 6153.9 6159.7 6164.0 6198.8 6203.9 6213.8 6222.9 5696.2 5879.0 5953.5 5971.2 5991.4 5874.3 5904.1 5916.9 5944.6 5949.6 5893.6 6149.0 6168.9 6186.4 6197.5 4191.0 4212.9 4221.6 4250.3 4252.7 6060.9 6068.3 6078.6 6100.5 6111.7 5686.3 5785.8 5835.1 5837.6 5975.7 5817.8 5825.3 5825.9 5833.9 5843.6 5586.9 5801.7 5809.8 5863.8 5889.4 5778.7 5813.7 5827.4 5845.2 5868.3 5705.2 5719.9 5743.6 5746.9 5752.6 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - PROCESS | 17985 | [#5] yui.html Cycles:180 Average:22790.42 Median:4484.48 stddev:34731.39 (774.5%) stddev-sans-first:34789.62 22:19:29 INFO - PROCESS | 17985 | Values: 813.0 818.1 866.9 875.9 887.6 15494.4 15627.4 15739.4 15749.3 15762.9 14810.8 14830.3 14899.9 14935.2 14943.3 711.3 730.3 731.4 732.0 843.4 841.7 841.8 849.4 849.9 851.0 904.5 915.0 915.1 915.1 915.1 905.2 909.1 909.9 910.2 910.7 550.1 561.8 650.7 671.5 676.4 13237.1 13744.0 13758.8 13759.1 13768.7 14196.9 14294.6 14461.7 14722.7 15018.3 13315.7 13397.3 13489.6 13525.5 13847.3 4629.7 4674.7 4733.7 4923.1 4928.0 88408.6 88613.0 89835.0 90112.5 90237.0 11887.8 11997.3 12061.3 12171.6 12271.1 24234.8 24237.9 24271.5 24272.0 24298.3 8159.6 8203.1 8239.3 8409.8 8455.4 4423.9 4545.1 4596.4 4618.6 4769.9 3279.0 3342.5 3372.6 3372.9 3379.7 562.3 567.5 574.7 579.6 581.2 579.4 655.0 674.6 677.4 705.7 9696.2 9883.0 10376.8 10471.6 10639.1 632.6 641.7 675.3 675.5 682.8 4968.7 5038.9 5095.8 5102.3 5127.4 121202.4 129507.0 129636.0 132555.0 138364.0 111951.0 116242.0 119706.4 120026.4 121146.4 98969.5 100680.0 101482.5 103530.0 104132.5 9134.3 9391.8 9498.2 10098.0 10161.4 52566.7 53116.2 55021.0 55139.2 55664.7 78535.0 80012.6 80015.0 81825.6 82914.0 11681.7 11704.7 11809.2 12025.2 12286.7 12971.0 13664.8 13793.6 13818.6 13849.3 12245.5 12445.6 12453.1 12885.8 13041.8 12645.3 12785.2 12978.7 13129.5 13286.7 12758.5 13198.7 13497.9 13526.4 13548.5 9167.2 9677.0 9719.5 9944.0 10009.5 10322.1 10366.4 10878.7 11085.2 11222.9 22:19:29 INFO - PROCESS | 17985 | -------- Summary: end -------- 22:19:29 INFO - PROCESS | 17985 | 22:19:29 INFO - TEST-INFO | 17985: exit 0 22:19:29 INFO - TEST-OK | dromaeo_css | took 1113077ms 22:19:29 INFO - TEST-START | kraken 22:19:29 INFO - operating with platform_type : linux_ 22:19:29 INFO - Initialising browser for kraken test... 22:19:29 INFO - TEST-INFO | started process 18310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3z7ar/profile http://localhost:33476/getInfo.html) 22:19:33 INFO - PROCESS | 18310 | __metrics Screen width/height:1600/1200 22:19:33 INFO - PROCESS | 18310 | colorDepth:24 22:19:33 INFO - PROCESS | 18310 | Browser inner width/height: 1024/697 22:19:33 INFO - PROCESS | 18310 | __metrics 22:19:34 INFO - PROCESS | 18310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:19:34 INFO - PROCESS | 18310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:34 INFO - PROCESS | 18310 | console.error: PushService: 22:19:34 INFO - PROCESS | 18310 | stateChangeProcessEnqueue: Error transitioning state 22:19:34 INFO - PROCESS | 18310 | UnknownError 22:19:35 INFO - TEST-INFO | 18310: exit 0 22:19:35 INFO - Browser initialized. 22:19:35 INFO - Running cycle 1/1 for kraken test... 22:19:35 INFO - TEST-INFO | started process 18401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3z7ar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:47 INFO - PROCESS | 18401 | RSS: Main: 144781312 22:19:47 INFO - PROCESS | 18401 | 22:19:49 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33476/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:50 INFO - PROCESS | 18401 | RSS: Main: 186589184 22:19:50 INFO - PROCESS | 18401 | 22:19:53 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33476/tests/kraken/driver.html?testName=audio-dft) 22:19:53 INFO - PROCESS | 18401 | RSS: Main: 175026176 22:19:53 INFO - PROCESS | 18401 | 22:19:56 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33476/tests/kraken/driver.html?testName=audio-fft) 22:19:57 INFO - PROCESS | 18401 | RSS: Main: 267055104 22:19:57 INFO - PROCESS | 18401 | 22:19:59 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33476/tests/kraken/driver.html?testName=audio-oscillator) 22:19:59 INFO - PROCESS | 18401 | RSS: Main: 173473792 22:19:59 INFO - PROCESS | 18401 | 22:20:01 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:02 INFO - PROCESS | 18401 | RSS: Main: 175591424 22:20:02 INFO - PROCESS | 18401 | 22:20:05 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33476/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:06 INFO - PROCESS | 18401 | RSS: Main: 210681856 22:20:06 INFO - PROCESS | 18401 | 22:20:09 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33476/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:10 INFO - PROCESS | 18401 | RSS: Main: 209297408 22:20:10 INFO - PROCESS | 18401 | 22:20:12 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33476/tests/kraken/driver.html?testName=json-parse-financial) 22:20:13 INFO - PROCESS | 18401 | RSS: Main: 209080320 22:20:13 INFO - PROCESS | 18401 | 22:20:14 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:15 INFO - PROCESS | 18401 | RSS: Main: 171671552 22:20:15 INFO - PROCESS | 18401 | 22:20:17 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:17 INFO - PROCESS | 18401 | RSS: Main: 178925568 22:20:17 INFO - PROCESS | 18401 | 22:20:19 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:20 INFO - PROCESS | 18401 | RSS: Main: 188837888 22:20:20 INFO - PROCESS | 18401 | 22:20:22 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:23 INFO - PROCESS | 18401 | RSS: Main: 197611520 22:20:23 INFO - PROCESS | 18401 | 22:20:26 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:26 INFO - PROCESS | 18401 | RSS: Main: 193146880 22:20:26 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | Cycle 1(1): loaded http://localhost:33476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33476/tests/kraken/driver.html?testName=ai-astar) 22:20:28 INFO - PROCESS | 18401 | RSS: Main: 244617216 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | __start_tp_report 22:20:28 INFO - PROCESS | 18401 | _x_x_mozilla_page_load 22:20:28 INFO - PROCESS | 18401 | _x_x_mozilla_page_load_details 22:20:28 INFO - PROCESS | 18401 | |i|pagename|runs| 22:20:28 INFO - PROCESS | 18401 | |0;ai-astar;109;112;112;110;110;112;112;112;110;111 22:20:28 INFO - PROCESS | 18401 | |1;audio-beat-detection;149;118;117;155;120;120;122;124;148;117 22:20:28 INFO - PROCESS | 18401 | |2;audio-dft;161;160;161;162;161;161;160;160;161;161 22:20:28 INFO - PROCESS | 18401 | |3;audio-fft;73;76;77;118;75;75;76;75;100;76 22:20:28 INFO - PROCESS | 18401 | |4;audio-oscillator;82;81;115;82;82;81;101;81;81;111 22:20:28 INFO - PROCESS | 18401 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;117;117;116 22:20:28 INFO - PROCESS | 18401 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;145 22:20:28 INFO - PROCESS | 18401 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;95 22:20:28 INFO - PROCESS | 18401 | |8;json-parse-financial;50;50;51;49;50;51;50;49;50;50 22:20:28 INFO - PROCESS | 18401 | |9;json-stringify-tinderbox;59;59;60;58;59;59;58;59;59;60 22:20:28 INFO - PROCESS | 18401 | |10;stanford-crypto-aes;81;74;72;77;73;73;74;73;73;73 22:20:28 INFO - PROCESS | 18401 | |11;stanford-crypto-ccm;126;120;130;121;127;124;123;116;161;134 22:20:28 INFO - PROCESS | 18401 | |12;stanford-crypto-pbkdf2;160;152;156;159;157;155;155;152;155;155 22:20:28 INFO - PROCESS | 18401 | |13;stanford-crypto-sha256-iterative;63;62;66;64;62;64;62;61;60;63 22:20:28 INFO - PROCESS | 18401 | __end_tp_report 22:20:28 INFO - PROCESS | 18401 | __start_cc_report 22:20:28 INFO - PROCESS | 18401 | _x_x_mozilla_cycle_collect,1592 22:20:28 INFO - PROCESS | 18401 | __end_cc_report 22:20:28 INFO - PROCESS | 18401 | __startTimestamp1476422428710__endTimestamp 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | ------- Summary: start ------- 22:20:28 INFO - PROCESS | 18401 | Number of tests: 14 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.15 (1.0%) stddev-sans-first:0.97 22:20:28 INFO - PROCESS | 18401 | Values: 109.0 112.0 112.0 110.0 110.0 112.0 112.0 112.0 110.0 111.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:123.00 stddev:15.21 (12.4%) stddev-sans-first:14.31 22:20:28 INFO - PROCESS | 18401 | Values: 149.0 118.0 117.0 155.0 120.0 120.0 122.0 124.0 148.0 117.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 22:20:28 INFO - PROCESS | 18401 | Values: 161.0 160.0 161.0 162.0 161.0 161.0 160.0 160.0 161.0 161.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:14.84 (19.7%) stddev-sans-first:15.37 22:20:28 INFO - PROCESS | 18401 | Values: 73.0 76.0 77.0 118.0 75.0 75.0 76.0 75.0 100.0 76.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:81.00 stddev:13.75 (17.0%) stddev-sans-first:14.30 22:20:28 INFO - PROCESS | 18401 | Values: 82.0 81.0 115.0 82.0 82.0 81.0 101.0 81.0 81.0 111.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:20:28 INFO - PROCESS | 18401 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:20:28 INFO - PROCESS | 18401 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:20:28 INFO - PROCESS | 18401 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 22:20:28 INFO - PROCESS | 18401 | Values: 50.0 50.0 51.0 49.0 50.0 51.0 50.0 49.0 50.0 50.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 22:20:28 INFO - PROCESS | 18401 | Values: 59.0 59.0 60.0 58.0 59.0 59.0 58.0 59.0 59.0 60.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:73.50 stddev:2.71 (3.7%) stddev-sans-first:1.42 22:20:28 INFO - PROCESS | 18401 | Values: 81.0 74.0 72.0 77.0 73.0 73.0 74.0 73.0 73.0 73.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:126.50 stddev:12.61 (10.0%) stddev-sans-first:13.35 22:20:28 INFO - PROCESS | 18401 | Values: 126.0 120.0 130.0 121.0 127.0 124.0 123.0 116.0 161.0 134.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.59 (1.7%) stddev-sans-first:2.20 22:20:28 INFO - PROCESS | 18401 | Values: 160.0 152.0 156.0 159.0 157.0 155.0 155.0 152.0 155.0 155.0 22:20:28 INFO - PROCESS | 18401 | 22:20:28 INFO - PROCESS | 18401 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 22:20:28 INFO - PROCESS | 18401 | Values: 63.0 62.0 66.0 64.0 62.0 64.0 62.0 61.0 60.0 63.0 22:20:28 INFO - PROCESS | 18401 | -------- Summary: end -------- 22:20:28 INFO - PROCESS | 18401 | 22:20:29 INFO - TEST-INFO | 18401: exit 0 22:20:29 INFO - TEST-OK | kraken | took 60033ms 22:20:29 INFO - SUITE-END | took 1173s 22:20:29 INFO - Completed test suite (00:19:33) 22:20:29 INFO - javascript benchmark 22:20:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.801177923435, 3100.22494376406, 3111.5799367085438, 3120.8751649934, 3143.0256620447662, 5357.008953343634, 5366.248725178473, 5384.515393614574, 5384.757685904134, 5407.05376559102, 5336.30628018358, 5340.706261155635, 5341.759620817063, 5349.117395629726, 5373.462653734625, 4795.184818580849, 4850.248211527201, 4859.07677541266, 4901.240307752304, 4912.21404575268, 4837.6129909607325, 4879.243717223836, 4970.105381031413, 4979.551840334369, 5000.4749501302385, 4794.184988551954, 4850.514948505156, 4858.611311095104, 4903.7302948338, 4904.877378065541, 4878.438979517347, 4909.45995940448, 4911.8280860169725, 4957.058158949824, 4990.0, 4856.198727210006, 4901.8774530636665, 4903.4606193318705, 4924.3105965164905, 4928.0, 5121.4110377306715, 5199.558037566773, 5213.7393130343335, 5289.9471005290225, 5314.787408503656, 5601.5238704709745, 5619.213310136584, 5630.0991841305195, 5676.063449530822, 5694.886102277973, 5730.19777231188, 5737.827865164052, 5743.856403589902, 5750.79872204475, 5756.769729210827, 5146.665466744649, 5180.689158650455, 5296.92054619181, 5330.040592693353, 5335.9466405336225, 5788.5369170466265, 5806.82579522615, 5809.4771470567, 5809.680467574324, 5819.73811178498, 5617.747201375948, 5621.381648018714, 5623.943760562423, 5625.887482250332, 5629.634073785191, 5587.916181257285, 5636.0, 5658.886822263532, 5693.373728889819, 5708.286464191976, 5726.226959360516, 5726.284214473191, 5739.913901291484, 5751.964646363611, 5752.971235143881, 5750.971245143831, 5754.223179870748, 5755.8561035974435, 5760.654360738369, 5778.046622307356, 4294.420253265832, 4369.148016136886, 4390.978045109754, 4436.112777444459, 4485.372047913294, 3971.0667993021616, 3973.384125460558, 3996.2606917720314, 3997.080671445584, 4016.116454380032, 5366.141417373202, 5395.082835917903, 5403.2705584746345, 5410.026195284808, 5443.346798384219, 5519.31008623922, 5574.916376254359, 5703.572232082611, 5712.65724056558, 5721.170430287585, 5434.098065677061, 5486.807961721401, 5511.3937466878615, 5521.806736764194, 5553.305836770403, 5068.341115654941, 5073.746312684351, 5076.796928122908, 5077.796888124433, 5109.105906466353, 5793.0, 5806.332271788714, 6020.157177994996, 6021.2473440819895, 6022.638641681513, 5628.690422026828, 5647.943520564741, 5673.631213971079, 5706.9714651426475, 5750.568707346882, 5895.764169433346, 5906.0, 5911.852203694942, 5912.260967378906, 5914.319853216935, 5502.779888804403, 5557.110862262019, 5618.634788738719, 5619.662820230799, 5626.746796394254, 5631.239782629293, 5674.517665998271, 5698.230738850202, 5754.56840736938, 5761.395053519488, 5610.943890561205, 5622.7750889963945, 5625.353084395347, 5628.437156284339, 5628.63413878113, 5412.269343638558, 5572.0, 5603.439656034364, 5619.100943848965, 5633.0, 5450.863728406663, 5547.916781248366, 5583.0787919992745, 5590.105583106683, 5675.716214189191, 5648.689322087324, 5674.886502270014, 5678.914816277676, 5680.488756011979, 5689.0, 5348.117560602457, 5514.944850551443, 5548.639338442988, 5557.277553917965, 5565.77736890536], "value": 5281.48553593996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3960121075294, 615.2954866677654, 619.8109576579144, 635.3773302163883, 644.5005121031201, 34418.65581344186, 46877.76561117194, 47691.76154119229, 47780.2832957505, 47831.760841195835, 48581.27128093073, 48599.27101093486, 49055.0, 49130.0, 49189.262161067614, 9401.388909720863, 9560.474173920431, 9564.091411315949, 9566.043395660414, 9568.904310956907, 8519.57402129894, 8744.038155802857, 11086.445677716123, 11361.943190284037, 11374.203805733601, 11457.197996140274, 11458.255213411143, 11539.0, 11558.13314001449, 11560.884391156107, 8565.186307300859, 11394.316341019525, 11448.370339631318, 11469.655910322663, 11479.942600286988, 8621.56892155396, 10851.403172825492, 11233.494492747846, 11244.943775281072, 11558.653240402802, 44883.32675009845, 45251.54748452539, 45255.32117018214, 45306.77346613246, 45396.0, 3555.768875023141, 3612.313660404541, 3617.403128483797, 3631.7094632429344, 3656.433252845813, 35244.118897027525, 35597.82201088978, 35921.46117808235, 36208.27583448316, 36297.45553816695, 4617.238155704338, 4634.536546345338, 4685.5314468553215, 4715.528447155291, 4718.669693121483, 354475.0, 356992.0, 357482.0, 358122.0, 359202.20398898097, 38058.80970595185, 65927.67036164789, 66286.33713662802, 66423.33576664267, 66460.33539664638, 39443.21113577712, 42034.579654203066, 42089.78955105266, 42092.579074209476, 42156.15687686229, 16555.751663725056, 16700.83299167017, 16756.162191890602, 16761.832381676028, 16765.077920714233, 12715.872841271654, 13183.14309569875, 13321.533746319026, 13432.395542200624, 13436.1266517678, 9339.719808405758, 9625.229981601455, 9635.22918166559, 9680.757981050388, 9770.413775173512, 3630.8366123524506, 3641.1079285574674, 3684.2078953024693, 3688.5758137814496, 3716.851325946986, 976.5703090640237, 995.5719040812376, 1002.9097381235724, 1010.7271036820017, 1145.2040831621944, 33583.16042098918, 33849.492257616155, 34172.66724803787, 34177.829110854786, 34220.65779342175, 1051.6371851711147, 1114.4483480676954, 1173.1260211142753, 1179.988200118005, 1225.9632211033684, 17739.467815965283, 17778.644427111645, 17781.0, 17976.101194940464, 18049.09754512269, 630158.0, 637277.0, 637349.0, 639602.0, 641102.0, 63617.681911590145, 63716.68141659262, 64097.0, 64149.0, 64222.0, 1307.4704744578462, 1367.5623800383783, 1377.15993244121, 1398.3427788939182, 1401.068289587413, 32428.513572296906, 35010.82494587511, 35032.474512882836, 35037.0, 35166.29667406587, 54247.72876135594, 54855.451445485036, 54893.451065488836, 54932.72533637306, 54971.0, 396828.0, 400030.0, 400094.0, 400469.0, 401055.0, 30502.847485763315, 31664.208394790316, 31743.841280793447, 32481.187970299987, 32577.534010969088, 51635.0, 51681.0, 51769.22346164886, 51855.481445186575, 52920.0, 43437.782811085744, 44255.77872110619, 44341.55658443374, 44531.55468445404, 45812.54187458216, 43060.35409468798, 43669.0, 44150.0, 45266.0946781056, 45316.54683453255, 41221.0, 44046.0, 45027.0, 45574.08851823011, 45690.54309456863, 36155.81922090373, 39221.41167882541, 39393.0, 39424.605753942094, 40469.39295910505, 29449.411011779215, 29773.0, 30001.399972000003, 30203.0, 30520.694793051785], "value": 20525.56624103747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.84486205517806, 409.8770368889332, 412.26822390257297, 422.69777109366794, 424.27449062103807, 14566.854331456681, 16405.75391369129, 20033.699494507575, 20778.792212077875, 20968.26611068613, 16353.182340882939, 16693.9983600984, 16695.749563756523, 19755.802441975575, 20316.288929887458, 5302.3106996090555, 5455.672659640434, 5465.234867118606, 5512.972435137819, 6173.629582225081, 4024.859129930453, 6118.388161183891, 6164.938350616504, 6208.037754148114, 6209.689515524228, 4203.096334288128, 5672.262605861232, 5943.167956486074, 5993.550483713717, 6062.666553339564, 5965.642061476326, 5966.582339236255, 6001.429864162941, 6032.366601506845, 6042.063480160582, 5720.2849643794525, 5847.736851841635, 5848.67832269225, 5853.678047707374, 5854.151148083504, 13134.605961821066, 14155.787663184958, 22474.887625561933, 23393.883030584908, 23494.0, 2367.5838477725383, 2494.8627825469594, 2515.5220508103403, 2539.441322908957, 2926.4732348177317, 9889.406635601816, 10176.084152426318, 15003.274623418338, 15921.840781592151, 15952.122633255167, 1793.7309403589436, 1840.1167439629053, 1842.106578309519, 1854.9907250463796, 1905.4474202481265, 80318.0, 81525.0, 83227.5838620803, 87519.0, 88559.55720221357, 11589.478473468715, 11665.125115616363, 11718.414079296, 11793.29240245588, 12068.405292862077, 16670.83329166717, 16671.49985500437, 16693.081880496447, 16705.749413758804, 16708.832911670972, 8330.50016998982, 8491.0, 8504.064552899175, 8538.87191692125, 8611.0, 7887.132415434297, 7914.366850651934, 8068.515889046676, 8100.108988011314, 8188.099309075997, 4910.607151427877, 4982.427020892644, 5028.472010438852, 5059.468755780664, 5116.488351164928, 1932.420273917819, 2054.9280775172797, 2076.1487790006026, 2084.7185629939763, 2099.139352865318, 777.4752042371376, 923.1783712495884, 940.6754669638964, 970.7476056225291, 983.188869182927, 20056.59886802285, 20603.484912876997, 20633.48416289605, 20651.58696826055, 20732.896335518526, 991.6975322526555, 1017.7048655889857, 1044.8223801953686, 1083.7290677330668, 1091.0398849012818, 11008.504617292241, 11216.607418740468, 11327.0, 11354.205205635526, 11490.850914908442, 487377.0, 495738.0, 495905.0, 499639.0, 510656.0, 67976.6601166991, 73839.63080184565, 96790.03209967811, 98908.0, 103210.48394758128, 1003.4681618742078, 1042.0985847242082, 1043.2905624175633, 1062.8671416072991, 1063.2079101069753, 17658.76388652782, 17925.641487169923, 18209.45371638853, 18215.089245537405, 18455.0, 44866.77566612146, 45202.77398612986, 45358.319625206306, 46318.76840615775, 46528.06943861172, 60990.39009609847, 61787.0, 62851.685741571, 62957.37042629515, 62994.685026574574, 8142.145074767301, 8281.668733250603, 8395.202455766692, 8604.440711353742, 8708.129187081242, 9777.560009799718, 13168.47326106945, 13248.867511324763, 13402.0, 13618.659533511345, 11433.0, 11440.42797860087, 11693.356865372487, 11861.881381186078, 12255.080868934687, 11303.265287756269, 11424.428778560872, 11594.71013224676, 11818.113641477095, 12350.44423000949, 11762.76474470523, 11852.525898963944, 12127.454264558293, 12216.75566488683, 12386.876131238932, 7275.1997280298065, 7654.540727556365, 8263.091059983517, 8396.706115285935, 8631.093735157969, 10682.946585267024, 10896.528968589138, 11489.253198542068, 11517.366544840113, 11775.411229438665], "value": 9388.534293600784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.641765976166, 1524.7484165112755, 1637.328695234954, 1742.3640371264491, 1799.541117015161, 7950.76147715568, 8491.575421228945, 8494.320454363644, 8495.872561911568, 8498.107698691641, 7447.0, 7693.269139431759, 7707.1522132565515, 7946.404019698517, 8173.632186551605, 2349.69453970984, 2376.144587948337, 2378.988105059472, 2379.8334116611845, 2381.8570885746826, 2314.8611083335054, 2321.292005938188, 2358.469344397514, 2359.4691194481275, 2363.82271329651, 2062.845286603503, 2131.0942849289067, 2269.704938358011, 2343.53129374125, 2347.4248809041724, 2296.2881506732965, 2314.5370925814905, 2318.026428899866, 2318.7913087822008, 2321.373229228099, 2321.3500219938273, 2322.9651555226687, 2327.4995875886766, 2328.2782337475437, 2329.6621989811383, 8372.28835548979, 8431.536265505394, 8438.240558349778, 8448.197421244971, 8448.78878028048, 4862.489438608931, 4888.853334399973, 4951.282064100686, 4952.380952380952, 4956.826511072095, 3277.2626159114006, 3287.3260981498734, 3391.0, 3408.5057666638445, 3410.454327307644, 1216.574199030341, 1220.725336799213, 1250.1686378558247, 1259.439549400517, 1269.8158766978736, 11183.720406989809, 11267.718307042389, 11271.830922536168, 11297.943510282477, 11301.321920684784, 4182.895427614334, 4225.640820530228, 4373.475182978063, 4382.364557139197, 4452.621527170227, 9710.126088652056, 9712.75718107053, 9714.125728684452, 9714.659986900424, 9717.514124293899, 5014.7994080236385, 5016.0971025215085, 5019.799208031638, 5021.5229553192385, 5068.873278168076, 4551.977240113778, 4635.397398338195, 4639.257718764981, 4646.233371493666, 4711.45818230901, 3936.8622098226424, 3976.980115099406, 4043.211573743092, 4074.4295798588223, 4181.247375472444, 1157.5196293538088, 1253.7053792358788, 1298.5909438526835, 1309.7118633900527, 1312.2454588611586, 838.2204549768774, 853.6030745703277, 926.9710621210451, 1014.9644762433279, 1017.995826910986, 5760.798372056958, 5808.303003639506, 5841.561882858802, 5856.736446859902, 5919.704014799243, 984.7390441532999, 1013.3058854684417, 1017.1049476460668, 1027.106417416852, 1064.6539874540806, 3926.0, 4120.855770048034, 4150.190712810973, 4164.479440069991, 4207.200631879933, 9534.666286679932, 9902.356346837432, 9974.650887218913, 10448.0, 10449.373037617766, 10226.130778883879, 10232.02795734404, 10236.283460157718, 10240.539175737109, 10241.48792560369, 7767.922320776833, 7775.805604859924, 7859.214078592095, 7878.172791856887, 7922.168172341821, 5644.379118296902, 5738.22533957927, 5868.149118377726, 5885.882282354243, 6055.3944605540855, 9425.0, 9485.288603354638, 9536.856947145938, 9571.521423928636, 9582.28132890022, 8948.86576701363, 9451.810963780548, 9458.858117128111, 9556.569954351931, 9713.854292185764, 7343.963280183779, 7481.925180748341, 7505.286997735207, 7511.211322811027, 7512.812179695551, 8146.75559733209, 8205.179482051986, 8209.917900820916, 8215.301699355621, 8218.21926916942, 7057.788266352018, 7141.214466408795, 7173.856522869618, 7185.173705023989, 7285.162206346126, 7288.562686238843, 7334.816629584089, 7366.152892417441, 7414.962925185339, 7423.628818559158, 6594.208694956636, 6632.071509988509, 6694.0, 6735.191776986793, 6764.4588432924265, 4985.351904252424, 5030.572401345927, 5051.696898186121, 5093.363329583802, 5145.382554093533, 4951.801927922987, 5039.899202016012, 5216.426193118678, 5231.843044708665, 5316.989771943318], "value": 4518.955269790851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.81897908702496, 316.6184747379408, 319.3533095481649, 320.5736370627066, 322.2057627947111, 5521.668699878005, 5525.889482210358, 5533.723313834313, 5539.750711217995, 5540.612157148991, 5457.2359869618285, 5466.371367292762, 5470.206820011096, 5476.123820188771, 5516.255305533752, 4017.919641607181, 4084.4281800547874, 4195.265828480004, 4206.789660516962, 4241.618254357108, 4222.387753775701, 4231.70378073535, 4262.318029115342, 4268.6798490113215, 4268.807903644328, 4173.812178451962, 4183.372494125891, 4184.456020717303, 4187.350960601112, 4204.8738537843765, 4053.6149065838845, 4201.852935147271, 4205.453291072141, 4210.978945105286, 4211.663066954637, 3710.703143748494, 3714.9226724249934, 3728.179800443898, 3732.962670373289, 3735.402335626287, 5367.677939323653, 5392.40683524812, 5392.730363481849, 5397.436217796554, 5415.756290966877, 4609.193391156534, 4761.6904901181315, 4830.975845120752, 4867.51324867514, 4877.780499877514, 5642.746076426571, 5664.291963504562, 5697.353693636076, 5711.371749107595, 5730.885382292331, 4006.238814625212, 4025.9798701006603, 4032.810320955296, 4052.817623206933, 4072.450219220397, 5905.6751878646655, 5950.363649996286, 5961.761529538813, 5989.0, 6028.336882942873, 4090.8363665453644, 4103.322951712994, 4106.07613287008, 4109.465769450012, 4112.91774164515, 4154.127633197002, 4161.25097482456, 4162.41726158338, 4171.457710497616, 4172.520160181618, 4681.555252251031, 4767.141914455431, 4810.63920205986, 4814.15752243356, 4826.8793280168275, 5737.356778445634, 5749.770009199585, 5752.913706294409, 5758.395368486333, 5770.365259821417, 1413.0814970269203, 1437.2598111972343, 1439.5753252790453, 1441.207335965215, 1445.3640398224748, 900.257287737606, 911.1389736698756, 916.2944532709777, 925.7916968681992, 929.1266209762802, 5515.227868098469, 5543.2793736814765, 5563.276774019351, 5573.359063707644, 5604.579656525777, 5852.239208902901, 5858.677772722456, 5874.647521148745, 5876.324222714357, 5886.8822623547285, 5324.494173053554, 5518.889622207534, 5573.944260557424, 5593.958205255052, 5659.575531835047, 3121.781475296753, 3126.6716994715684, 3134.0754477429214, 3147.630780610442, 3153.7227422893766, 5904.261967254093, 6097.207363042776, 6116.938830611726, 6131.294901086432, 6152.630842149485, 6106.511479081662, 6145.139680444741, 6151.784687536005, 6153.907691384633, 6159.6612186329285, 6164.0, 6198.845028874224, 6203.875922481525, 6213.813585592439, 6222.906656400158, 5696.231008813757, 5879.029960056543, 5953.523718102455, 5971.193888825127, 5991.370906054975, 5874.265716785402, 5904.143899134688, 5916.881662366643, 5944.554158438048, 5949.583529152917, 5893.616914900518, 6149.0, 6168.8766224674355, 6186.350433204629, 6197.5351848610635, 4190.958090419057, 4212.91574168521, 4221.577842215754, 4250.341197114452, 4252.659787217077, 6060.90908636362, 6068.271807383142, 6078.6048906820915, 6100.511959043177, 6111.716539526749, 5686.2607860977805, 5785.768569257182, 5835.066389377679, 5837.562182836219, 5975.731092100779, 5817.76728930838, 5825.300963884361, 5825.94174058254, 5833.883322333614, 5843.649381037151, 5586.888262234814, 5801.680907550125, 5809.82570522885, 5863.794767183128, 5889.411058894248, 5778.711064446845, 5813.709314534341, 5827.388124246893, 5845.240118784531, 5868.2664666916635, 5705.201271822031, 5719.8570035749435, 5743.56923230751, 5746.942530574641, 5752.568557358299], "value": 4371.292782144675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.991870081299, 818.0592318833341, 866.9219770220678, 875.851105312097, 887.6493784954945, 15494.38022479101, 15627.374905003815, 15739.449119280798, 15749.291281892314, 15762.92118539407, 14810.777838332433, 14830.332635031422, 14899.85100149001, 14935.17856517891, 14943.252837358115, 711.3171355498714, 730.2879692300019, 731.4221764805797, 732.0264048815063, 843.439112989861, 841.6507149532968, 841.8400503904269, 849.4308813095241, 849.9447535910177, 851.0425771007616, 904.4799240436743, 914.9980771055716, 915.0666320353236, 915.0940568836837, 915.1443400420628, 905.2034209895315, 909.1408618855185, 909.8908131024286, 910.1899309614415, 910.6539514984297, 550.1060776238612, 561.8089849451165, 650.7136859781681, 671.493022767812, 676.3980057748607, 13237.073404861663, 13744.0, 13758.793618095737, 13759.10565813219, 13768.724625507533, 14196.929015354961, 14294.571162865132, 14461.71076578473, 14722.705545889023, 15018.324175412132, 13315.684845600532, 13397.330133493384, 13489.595312140651, 13525.526606568723, 13847.307634618228, 4629.652776041777, 4674.7428891410955, 4733.692309999839, 4923.089228492705, 4927.950720492785, 88408.55795721045, 88613.0, 89835.0, 90112.54943725305, 90237.0, 11887.762244755057, 11997.340146291863, 12061.336626485452, 12171.634850954486, 12271.141020128505, 24234.757652423603, 24237.878810605835, 24271.514569708506, 24272.0, 24298.271051868473, 8159.632816523271, 8203.097659257477, 8239.340852731768, 8409.789755256044, 8455.408121431441, 4423.867283981485, 4545.0909818036525, 4596.37948876904, 4618.56123668251, 4769.928451073237, 3278.950815737766, 3342.495876855376, 3372.629010808809, 3372.9494057589154, 3379.732600274897, 562.3139769481227, 567.4637467593168, 574.7097715653651, 579.6000759475949, 581.1515187825737, 579.3569138256532, 654.9901751473732, 674.6390680985747, 677.3801971196399, 705.7353492440335, 9696.17582505495, 9882.950585247028, 10376.792464150674, 10471.633492827714, 10639.14886809069, 632.5761739634456, 641.6791604197902, 675.2774531251612, 675.4866301610713, 682.8327059870363, 4968.72672003036, 5038.924416133761, 5095.770690318945, 5102.311187989648, 5127.3847138343635, 121202.39398803125, 129507.0, 129636.0, 132555.0, 138364.0, 111951.0, 116242.0, 119706.40146799211, 120026.39986800184, 121146.39426802809, 98969.50515247378, 100680.0, 101482.49258753807, 103530.0, 104132.47933760282, 9134.314926380415, 9391.812163756824, 9498.19265362452, 10098.0, 10161.390316581028, 52566.73716631392, 53116.2032569504, 55021.0, 55139.17291240715, 55664.72167639136, 78535.0, 80012.59993699995, 80015.0, 81825.59087204526, 82914.0, 11681.707957301136, 11704.70738231517, 11809.23239989398, 12025.218360806519, 12286.692832679255, 12971.0, 13664.769612582384, 13793.586192414243, 13818.585442436743, 13849.307534623431, 12245.510179592717, 12445.564405245774, 12453.128281020605, 12885.7623034937, 13041.804372934603, 12645.304508252135, 12785.232886026868, 12978.675533111747, 13129.474821007052, 13286.734265314833, 12758.48966041385, 13198.670033249246, 13497.932510337385, 13526.39131239077, 13548.525801596898, 9167.220786233245, 9676.95161524216, 9719.514024298614, 9943.950280248553, 10009.499525023866, 10322.066008575192, 10366.429846358522, 10878.673639790502, 11085.168612354268, 11222.943885280521], "value": 7716.958437725743, "unit": "score"}], "name": "dromaeo_css", "value": 7330.464687301671, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 110.0, 110.0, 112.0, 112.0, 112.0, 110.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 117.0, 155.0, 120.0, 120.0, 122.0, 124.0, 148.0, 117.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 77.0, 118.0, 75.0, 75.0, 76.0, 75.0, 100.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 115.0, 82.0, 82.0, 81.0, 101.0, 81.0, 81.0, 111.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 49.0, 50.0, 51.0, 50.0, 49.0, 50.0, 50.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 72.0, 77.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 130.0, 121.0, 127.0, 124.0, 123.0, 116.0, 161.0, 134.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 152.0, 156.0, 159.0, 157.0, 155.0, 155.0, 152.0, 155.0, 155.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 64.0, 62.0, 64.0, 62.0, 61.0, 60.0, 63.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1459.5, "alertThreshold": 2.0}]} 22:20:29 INFO - Return code: 0 22:20:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:20:30 INFO - # TBPL SUCCESS # 22:20:30 INFO - Running post-action listener: _resource_record_post_action 22:20:30 INFO - [mozharness: 2016-10-14 05:20:30.035129Z] Finished run-tests step (success) 22:20:30 INFO - Running post-run listener: _resource_record_post_run 22:20:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 357310464; Read time: 0; Write time: 220664 22:20:30 INFO - TinderboxPrint: CPU usage
12.9% 22:20:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:20:30 INFO - TinderboxPrint: I/O write bytes / time
357,310,464 / 220,664 22:20:30 INFO - TinderboxPrint: CPU idle
8,263.3 (87.1%) 22:20:30 INFO - TinderboxPrint: CPU user
1,183.5 (12.5%) 22:20:30 INFO - TinderboxPrint: Swap in / out
0 / 0 22:20:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108105728; Read time: 0; Write time: 95452 22:20:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 249204736; Read time: 0; Write time: 125212 22:20:30 INFO - Running post-run listener: _upload_blobber_files 22:20:30 INFO - Blob upload gear active. 22:20:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:30 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 22:20:30 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:30 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:31 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:31 INFO - (blobuploader) - INFO - Done attempting. 22:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:20:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:34 INFO - (blobuploader) - INFO - Done attempting. 22:20:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:35 INFO - (blobuploader) - INFO - Done attempting. 22:20:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:35 INFO - Return code: 0 22:20:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f40a678187c0fb10e2ef71748532d7fcaf4a29bc098fedbd3013a46e5e83de1039c235787563855ddec0f4d1148331fed2d66ff38e092b251944f7d189a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01ba7d1b3fae52e82aa698227394f96ccfae35794ee8ee604a30e3eec8cbe8ecd4c558065b99bd70a8a0528fe28596e98fa8457d25689cd4da3284fdf6a62cf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8225ad8086bf0d07dcbf0699c87b4db68b35d80e034d338c0e8090e432c6b18760811253be9695ef314aaa583bfc1037b29e7ebc8da4cb2607801bd5b5eba826"} 22:20:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:35 INFO - Contents: 22:20:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f40a678187c0fb10e2ef71748532d7fcaf4a29bc098fedbd3013a46e5e83de1039c235787563855ddec0f4d1148331fed2d66ff38e092b251944f7d189a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01ba7d1b3fae52e82aa698227394f96ccfae35794ee8ee604a30e3eec8cbe8ecd4c558065b99bd70a8a0528fe28596e98fa8457d25689cd4da3284fdf6a62cf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8225ad8086bf0d07dcbf0699c87b4db68b35d80e034d338c0e8090e432c6b18760811253be9695ef314aaa583bfc1037b29e7ebc8da4cb2607801bd5b5eba826"} 22:20:35 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:35 INFO - Copying logs to upload dir... 22:20:35 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.172440 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-10-13 22:20:35.645597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:20:35.649162) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f40a678187c0fb10e2ef71748532d7fcaf4a29bc098fedbd3013a46e5e83de1039c235787563855ddec0f4d1148331fed2d66ff38e092b251944f7d189a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01ba7d1b3fae52e82aa698227394f96ccfae35794ee8ee604a30e3eec8cbe8ecd4c558065b99bd70a8a0528fe28596e98fa8457d25689cd4da3284fdf6a62cf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8225ad8086bf0d07dcbf0699c87b4db68b35d80e034d338c0e8090e432c6b18760811253be9695ef314aaa583bfc1037b29e7ebc8da4cb2607801bd5b5eba826"} build_url:https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/bkNf1KUaSP-uMaFfVSjHtQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f40a678187c0fb10e2ef71748532d7fcaf4a29bc098fedbd3013a46e5e83de1039c235787563855ddec0f4d1148331fed2d66ff38e092b251944f7d189a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/01ba7d1b3fae52e82aa698227394f96ccfae35794ee8ee604a30e3eec8cbe8ecd4c558065b99bd70a8a0528fe28596e98fa8457d25689cd4da3284fdf6a62cf8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8225ad8086bf0d07dcbf0699c87b4db68b35d80e034d338c0e8090e432c6b18760811253be9695ef314aaa583bfc1037b29e7ebc8da4cb2607801bd5b5eba826"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 22:20:35.679196) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:20:35.679593) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1476421201.187310-1635818217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 22:20:35.760144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:20:35.760501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 22:20:35.760874) ========= ========= Total master_lag: 0.18 =========