builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1474801308.79 results: success (0) buildid: 20160925004010 builduid: eedd3bf1102b479e82080aaa7d0b1a54 revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:48.793904) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:48.794361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:48.794661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:48.847772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:48.848089) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-25 04:01:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-09-25 04:01:49 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.048343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.048667) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.098428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.098821) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --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 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-25 04:01:49,534 truncating revision to first 12 chars 2016-09-25 04:01:49,534 Setting DEBUG logging. 2016-09-25 04:01:49,534 attempt 1/10 2016-09-25 04:01:49,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1fee8de1111f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 04:01:49,866 unpacking tar archive at: mozilla-aurora-1fee8de1111f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719804 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.838264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.838582) ========= script_repo_revision: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.839024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.839377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 04:01:49.850393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-25 04:01:49.850753) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:01:50 INFO - MultiFileLogger online at 20160925 04:01:50 in /builds/slave/test 04:01:50 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 04:01:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:01:50 INFO - {'append_to_log': False, 04:01:50 INFO - 'base_work_dir': '/builds/slave/test', 04:01:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:01:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:01:50 INFO - 'branch': 'Mozilla-Aurora', 04:01:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:01:50 INFO - 'config_files': ('talos/linux_config.py',), 04:01:50 INFO - 'default_actions': ('clobber', 04:01:50 INFO - 'read-buildbot-config', 04:01:50 INFO - 'download-and-extract', 04:01:50 INFO - 'populate-webroot', 04:01:50 INFO - 'create-virtualenv', 04:01:50 INFO - 'install', 04:01:50 INFO - 'run-tests'), 04:01:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:01:50 INFO - 'download_minidump_stackwalk': True, 04:01:50 INFO - 'download_symbols': 'ondemand', 04:01:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:01:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:01:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:01:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:01:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:01:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:01:50 INFO - 'installer_path': 'installer.exe', 04:01:50 INFO - 'log_level': 'info', 04:01:50 INFO - 'log_name': 'talos', 04:01:50 INFO - 'log_to_console': True, 04:01:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:01:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:01:50 INFO - 'opt_config_files': (), 04:01:50 INFO - 'pip_index': False, 04:01:50 INFO - 'sps_profile': False, 04:01:50 INFO - 'sps_profile_interval': 0, 04:01:50 INFO - 'suite': 'dromaeojs', 04:01:50 INFO - 'system_bits': '32', 04:01:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:01:50 INFO - 'title': 'talos-linux64-ix-041', 04:01:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:01:50 INFO - 'use_talos_json': True, 04:01:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:01:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:01:50 INFO - 'work_dir': 'build'} 04:01:50 INFO - [mozharness: 2016-09-25 11:01:50.378908Z] Running clobber step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: clobber 04:01:50 INFO - rmtree: /builds/slave/test/build 04:01:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2016-09-25 11:01:50.835969Z] Finished clobber step (success) 04:01:50 INFO - [mozharness: 2016-09-25 11:01:50.836070Z] Running read-buildbot-config step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: read_buildbot_config 04:01:50 INFO - Using buildbot properties: 04:01:50 INFO - { 04:01:50 INFO - "project": "", 04:01:50 INFO - "product": "firefox", 04:01:50 INFO - "script_repo_revision": "production", 04:01:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:01:50 INFO - "repository": "", 04:01:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:01:50 INFO - "buildid": "20160925004010", 04:01:50 INFO - "stage_platform": "linux64-pgo", 04:01:50 INFO - "basedir": "/builds/slave/test", 04:01:50 INFO - "nightly_build": "True", 04:01:50 INFO - "buildnumber": 531, 04:01:50 INFO - "slavename": "talos-linux64-ix-041", 04:01:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:01:50 INFO - "platform": "ubuntu64_hw", 04:01:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:01:50 INFO - "branch": "mozilla-aurora", 04:01:50 INFO - "repo_path": "releases/mozilla-aurora", 04:01:50 INFO - "revision": "1fee8de1111fdcc6fb5d95d4afef92c913fc87f2", 04:01:50 INFO - "pgo_build": "True", 04:01:50 INFO - "builduid": "eedd3bf1102b479e82080aaa7d0b1a54", 04:01:50 INFO - "slavebuilddir": "test" 04:01:50 INFO - } 04:01:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 04:01:50 INFO - Running post-action listener: _resource_record_post_action 04:01:50 INFO - [mozharness: 2016-09-25 11:01:50.838604Z] Finished read-buildbot-config step (success) 04:01:50 INFO - [mozharness: 2016-09-25 11:01:50.838692Z] Running download-and-extract step. 04:01:50 INFO - Running pre-action listener: _resource_record_pre_action 04:01:50 INFO - Running main action method: download_and_extract 04:01:50 INFO - mkdir: /builds/slave/test/build/tests 04:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:01:50 INFO - trying https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:01:50 INFO - Downloading https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/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 04:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/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 04:01:51 INFO - Downloaded 1361 bytes. 04:01:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 04:01:51 INFO - Using the following test package requirements: 04:01:51 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:01:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:01:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:01:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'jsshell-linux-x86_64.zip'], 04:01:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:01:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 04:01:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:01:51 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:01:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:01:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 04:01:51 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:01:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:01:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:01:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:51 INFO - Fetch https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:01:52 INFO - Expected file size: 21898354 04:01:56 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 04:01:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 04:01:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:01:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:01:57 INFO - Expected file size: 21898354 04:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 04:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:02:02 INFO - Expected file size: 14414059 04:02:03 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')]} 04:02:03 INFO - trying https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:02:03 INFO - Downloading https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/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 04:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/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 04:02:05 INFO - Downloaded 63932795 bytes. 04:02:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:02:05 INFO - mkdir: /builds/slave/test/properties 04:02:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:05 INFO - Contents: 04:02:05 INFO - build_url:https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 04:02:05 INFO - Running post-action listener: _resource_record_post_action 04:02:05 INFO - Running post-action listener: set_extra_try_arguments 04:02:05 INFO - [mozharness: 2016-09-25 11:02:05.980298Z] Finished download-and-extract step (success) 04:02:05 INFO - [mozharness: 2016-09-25 11:02:05.980527Z] Running populate-webroot step. 04:02:05 INFO - Running pre-action listener: _resource_record_pre_action 04:02:05 INFO - Running main action method: populate_webroot 04:02:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:05 INFO - '--tppagecycles', 04:02:05 INFO - '7'], 04:02:05 INFO - 'tests': ['tsvgm']}}, 04:02:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['damp', 'tps']}, 04:02:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'tests': ['damp', 'tps']}, 04:02:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['dromaeo_dom']}, 04:02:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['basic_compositor_video']}, 04:02:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:02:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['a11yr', 04:02:05 INFO - 'ts_paint', 04:02:05 INFO - 'tpaint', 04:02:05 INFO - 'sessionrestore', 04:02:05 INFO - 'sessionrestore_no_auto_restore', 04:02:05 INFO - 'tabpaint']}, 04:02:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['tsvgx', 04:02:05 INFO - 'tsvgr_opacity', 04:02:05 INFO - 'tart', 04:02:05 INFO - 'tscrollx', 04:02:05 INFO - 'cart']}, 04:02:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:05 INFO - 'tsvgr_opacity', 04:02:05 INFO - 'tart', 04:02:05 INFO - 'tscrollx', 04:02:05 INFO - 'cart']}, 04:02:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'talos_options': ['--disable-e10s'], 04:02:05 INFO - 'tests': ['tp5o']}, 04:02:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'tests': ['tp5o']}, 04:02:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'talos_options': ['--disable-e10s', 04:02:05 INFO - '--xperf_path', 04:02:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:05 INFO - 'tests': ['tp5n']}, 04:02:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:05 INFO - 'talos_options': ['--xperf_path', 04:02:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:05 INFO - 'tests': ['tp5n']}}, 04:02:05 INFO - 'talos.zip': {'path': '', 04:02:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:05 INFO - Running post-action listener: _resource_record_post_action 04:02:05 INFO - [mozharness: 2016-09-25 11:02:05.999713Z] Finished populate-webroot step (success) 04:02:05 INFO - [mozharness: 2016-09-25 11:02:05.999803Z] Running create-virtualenv step. 04:02:05 INFO - Running pre-action listener: _resource_record_pre_action 04:02:05 INFO - Running main action method: create_virtualenv 04:02:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:06 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 04:02:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:06 INFO - Using real prefix '/usr' 04:02:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:08 INFO - Installing pip.................done. 04:02:08 INFO - Return code: 0 04:02:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:08 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')]} 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:08 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')]} 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:08 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:08 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 04:02:08 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 04:02:08 INFO - Using env: {'DISPLAY': ':0', 04:02:08 INFO - 'HOME': '/home/cltbld', 04:02:08 INFO - 'LANG': 'en_US.UTF-8', 04:02:08 INFO - 'LANGUAGE': 'en_US:en', 04:02:08 INFO - 'LOGNAME': 'cltbld', 04:02:08 INFO - 'MAIL': '/var/mail/cltbld', 04:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:08 INFO - 'MOZ_NO_REMOTE': '1', 04:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:08 INFO - 'NO_EM_RESTART': '1', 04:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:08 INFO - 'PWD': '/builds/slave/test', 04:02:08 INFO - 'SHELL': '/bin/bash', 04:02:08 INFO - 'SHLVL': '1', 04:02:08 INFO - 'TERM': 'linux', 04:02:08 INFO - 'TMOUT': '86400', 04:02:08 INFO - 'USER': 'cltbld', 04:02:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:08 INFO - '_': '/tools/buildbot/bin/python'} 04:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:08 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 04:02:08 INFO - Cleaning up... 04:02:08 INFO - Return code: 0 04:02:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02:08 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')]} 04:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:08 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')]} 04:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:08 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:08 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 04:02:08 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 04:02:08 INFO - Using env: {'DISPLAY': ':0', 04:02:08 INFO - 'HOME': '/home/cltbld', 04:02:08 INFO - 'LANG': 'en_US.UTF-8', 04:02:08 INFO - 'LANGUAGE': 'en_US:en', 04:02:08 INFO - 'LOGNAME': 'cltbld', 04:02:08 INFO - 'MAIL': '/var/mail/cltbld', 04:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:08 INFO - 'MOZ_NO_REMOTE': '1', 04:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:08 INFO - 'NO_EM_RESTART': '1', 04:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:08 INFO - 'PWD': '/builds/slave/test', 04:02:08 INFO - 'SHELL': '/bin/bash', 04:02:08 INFO - 'SHLVL': '1', 04:02:08 INFO - 'TERM': 'linux', 04:02:08 INFO - 'TMOUT': '86400', 04:02:08 INFO - 'USER': 'cltbld', 04:02:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:08 INFO - '_': '/tools/buildbot/bin/python'} 04:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:08 INFO - Downloading/unpacking psutil>=3.1.1 04:02:08 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 04:02:08 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 04:02:08 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 04:02:08 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 04:02:08 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 04:02:08 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 04:02:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:10 INFO - Installing collected packages: psutil 04:02:10 INFO - Running setup.py install for psutil 04:02:11 INFO - building 'psutil._psutil_linux' extension 04:02:11 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 04:02:11 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 04:02:11 INFO - building 'psutil._psutil_posix' extension 04:02:11 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 04:02:11 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 04:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:11 INFO - Successfully installed psutil 04:02:11 INFO - Cleaning up... 04:02:11 INFO - Return code: 0 04:02:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:11 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:11 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 04:02:11 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 04:02:11 INFO - Using env: {'DISPLAY': ':0', 04:02:11 INFO - 'HOME': '/home/cltbld', 04:02:11 INFO - 'LANG': 'en_US.UTF-8', 04:02:11 INFO - 'LANGUAGE': 'en_US:en', 04:02:11 INFO - 'LOGNAME': 'cltbld', 04:02:11 INFO - 'MAIL': '/var/mail/cltbld', 04:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:11 INFO - 'MOZ_NO_REMOTE': '1', 04:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:11 INFO - 'NO_EM_RESTART': '1', 04:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:11 INFO - 'PWD': '/builds/slave/test', 04:02:11 INFO - 'SHELL': '/bin/bash', 04:02:11 INFO - 'SHLVL': '1', 04:02:11 INFO - 'TERM': 'linux', 04:02:11 INFO - 'TMOUT': '86400', 04:02:11 INFO - 'USER': 'cltbld', 04:02:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:11 INFO - '_': '/tools/buildbot/bin/python'} 04:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:13 INFO - Installing collected packages: mozsystemmonitor 04:02:13 INFO - Running setup.py install for mozsystemmonitor 04:02:13 INFO - Successfully installed mozsystemmonitor 04:02:13 INFO - Cleaning up... 04:02:13 INFO - Return code: 0 04:02:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:13 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:13 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 04:02:13 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 04:02:13 INFO - Using env: {'DISPLAY': ':0', 04:02:13 INFO - 'HOME': '/home/cltbld', 04:02:13 INFO - 'LANG': 'en_US.UTF-8', 04:02:13 INFO - 'LANGUAGE': 'en_US:en', 04:02:13 INFO - 'LOGNAME': 'cltbld', 04:02:13 INFO - 'MAIL': '/var/mail/cltbld', 04:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:13 INFO - 'MOZ_NO_REMOTE': '1', 04:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:13 INFO - 'NO_EM_RESTART': '1', 04:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:13 INFO - 'PWD': '/builds/slave/test', 04:02:13 INFO - 'SHELL': '/bin/bash', 04:02:13 INFO - 'SHLVL': '1', 04:02:13 INFO - 'TERM': 'linux', 04:02:13 INFO - 'TMOUT': '86400', 04:02:13 INFO - 'USER': 'cltbld', 04:02:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:13 INFO - '_': '/tools/buildbot/bin/python'} 04:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:02:14 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 04:02:14 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 04:02:14 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 04:02:14 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 04:02:14 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 04:02:14 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 04:02:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:15 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 04:02:15 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 04:02:15 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 04:02:15 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 04:02:15 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 04:02:15 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 04:02:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:16 INFO - warning: no files found matching '*.txt' 04:02:16 INFO - no previously-included directories found matching 'build' 04:02:16 INFO - no previously-included directories found matching 'dist' 04:02:16 INFO - no previously-included directories found matching '.git*' 04:02:16 INFO - Installing collected packages: jsonschema, functools32 04:02:16 INFO - Running setup.py install for functools32 04:02:16 INFO - warning: no files found matching '*.txt' 04:02:16 INFO - no previously-included directories found matching 'build' 04:02:16 INFO - no previously-included directories found matching 'dist' 04:02:16 INFO - no previously-included directories found matching '.git*' 04:02:16 INFO - Successfully installed jsonschema functools32 04:02:16 INFO - Cleaning up... 04:02:16 INFO - Return code: 0 04:02:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:16 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:16 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 04:02:16 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 04:02:16 INFO - Using env: {'DISPLAY': ':0', 04:02:16 INFO - 'HOME': '/home/cltbld', 04:02:16 INFO - 'LANG': 'en_US.UTF-8', 04:02:16 INFO - 'LANGUAGE': 'en_US:en', 04:02:16 INFO - 'LOGNAME': 'cltbld', 04:02:16 INFO - 'MAIL': '/var/mail/cltbld', 04:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:16 INFO - 'MOZ_NO_REMOTE': '1', 04:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:16 INFO - 'NO_EM_RESTART': '1', 04:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:16 INFO - 'PWD': '/builds/slave/test', 04:02:16 INFO - 'SHELL': '/bin/bash', 04:02:16 INFO - 'SHLVL': '1', 04:02:16 INFO - 'TERM': 'linux', 04:02:16 INFO - 'TMOUT': '86400', 04:02:16 INFO - 'USER': 'cltbld', 04:02:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:16 INFO - '_': '/tools/buildbot/bin/python'} 04:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:02:16 INFO - Cleaning up... 04:02:16 INFO - Return code: 0 04:02:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:16 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:16 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 04:02:16 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 04:02:16 INFO - Using env: {'DISPLAY': ':0', 04:02:16 INFO - 'HOME': '/home/cltbld', 04:02:16 INFO - 'LANG': 'en_US.UTF-8', 04:02:16 INFO - 'LANGUAGE': 'en_US:en', 04:02:16 INFO - 'LOGNAME': 'cltbld', 04:02:16 INFO - 'MAIL': '/var/mail/cltbld', 04:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:16 INFO - 'MOZ_NO_REMOTE': '1', 04:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:16 INFO - 'NO_EM_RESTART': '1', 04:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:16 INFO - 'PWD': '/builds/slave/test', 04:02:16 INFO - 'SHELL': '/bin/bash', 04:02:16 INFO - 'SHLVL': '1', 04:02:16 INFO - 'TERM': 'linux', 04:02:16 INFO - 'TMOUT': '86400', 04:02:16 INFO - 'USER': 'cltbld', 04:02:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:16 INFO - '_': '/tools/buildbot/bin/python'} 04:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:16 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 04:02:16 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 04:02:16 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 04:02:16 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 04:02:16 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 04:02:16 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 04:02:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:18 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 04:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:19 INFO - Downloading docopt-0.6.1.tar.gz 04:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:19 INFO - Running setup.py install for blobuploader 04:02:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:19 INFO - Running setup.py install for requests 04:02:19 INFO - Running setup.py install for docopt 04:02:20 INFO - Successfully installed blobuploader requests docopt 04:02:20 INFO - Cleaning up... 04:02:20 INFO - Return code: 0 04:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:20 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:20 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 04:02:20 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 04:02:20 INFO - Using env: {'DISPLAY': ':0', 04:02:20 INFO - 'HOME': '/home/cltbld', 04:02:20 INFO - 'LANG': 'en_US.UTF-8', 04:02:20 INFO - 'LANGUAGE': 'en_US:en', 04:02:20 INFO - 'LOGNAME': 'cltbld', 04:02:20 INFO - 'MAIL': '/var/mail/cltbld', 04:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:20 INFO - 'MOZ_NO_REMOTE': '1', 04:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:20 INFO - 'NO_EM_RESTART': '1', 04:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:20 INFO - 'PWD': '/builds/slave/test', 04:02:20 INFO - 'SHELL': '/bin/bash', 04:02:20 INFO - 'SHLVL': '1', 04:02:20 INFO - 'TERM': 'linux', 04:02:20 INFO - 'TMOUT': '86400', 04:02:20 INFO - 'USER': 'cltbld', 04:02:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:20 INFO - '_': '/tools/buildbot/bin/python'} 04:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:20 INFO - Running setup.py (path:/tmp/pip-p_2hCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:20 INFO - Running setup.py (path:/tmp/pip-09ZRGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:20 INFO - Running setup.py (path:/tmp/pip-FSjPUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:20 INFO - Running setup.py (path:/tmp/pip-Eknqmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:20 INFO - Running setup.py (path:/tmp/pip-auD3rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:20 INFO - Running setup.py (path:/tmp/pip-msdpge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:20 INFO - Running setup.py (path:/tmp/pip-BRRnFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:20 INFO - Running setup.py (path:/tmp/pip-3O4iXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:20 INFO - Running setup.py (path:/tmp/pip-VDwXvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:21 INFO - Running setup.py (path:/tmp/pip-fkwJPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:21 INFO - Running setup.py (path:/tmp/pip-xtc7D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:21 INFO - Running setup.py (path:/tmp/pip-MoYEr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:21 INFO - Running setup.py (path:/tmp/pip-XJaYMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:21 INFO - Running setup.py (path:/tmp/pip-l97xL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:21 INFO - Running setup.py (path:/tmp/pip-8nMosS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:21 INFO - Running setup.py (path:/tmp/pip-VLWnDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:21 INFO - Running setup.py (path:/tmp/pip-OH41WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:21 INFO - Running setup.py install for manifestparser 04:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:21 INFO - Running setup.py install for mozcrash 04:02:21 INFO - Running setup.py install for mozdebug 04:02:21 INFO - Running setup.py install for mozdevice 04:02:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozfile 04:02:22 INFO - Running setup.py install for mozhttpd 04:02:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozinfo 04:02:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozInstall 04:02:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozleak 04:02:22 INFO - Running setup.py install for mozlog 04:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for moznetwork 04:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozprocess 04:02:22 INFO - Running setup.py install for mozprofile 04:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:22 INFO - Running setup.py install for mozrunner 04:02:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:23 INFO - Running setup.py install for mozscreenshot 04:02:23 INFO - Running setup.py install for moztest 04:02:23 INFO - Running setup.py install for mozversion 04:02:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:23 INFO - Cleaning up... 04:02:23 INFO - Return code: 0 04:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:23 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:23 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 04:02:23 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 04:02:23 INFO - Using env: {'DISPLAY': ':0', 04:02:23 INFO - 'HOME': '/home/cltbld', 04:02:23 INFO - 'LANG': 'en_US.UTF-8', 04:02:23 INFO - 'LANGUAGE': 'en_US:en', 04:02:23 INFO - 'LOGNAME': 'cltbld', 04:02:23 INFO - 'MAIL': '/var/mail/cltbld', 04:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:23 INFO - 'MOZ_NO_REMOTE': '1', 04:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:23 INFO - 'NO_EM_RESTART': '1', 04:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:23 INFO - 'PWD': '/builds/slave/test', 04:02:23 INFO - 'SHELL': '/bin/bash', 04:02:23 INFO - 'SHLVL': '1', 04:02:23 INFO - 'TERM': 'linux', 04:02:23 INFO - 'TMOUT': '86400', 04:02:23 INFO - 'USER': 'cltbld', 04:02:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:23 INFO - '_': '/tools/buildbot/bin/python'} 04:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:23 INFO - Running setup.py (path:/tmp/pip-WOCYhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:23 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)) 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:23 INFO - Running setup.py (path:/tmp/pip-Zc_Egf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:23 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)) 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:23 INFO - Running setup.py (path:/tmp/pip-iJRcNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:23 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)) 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:23 INFO - Running setup.py (path:/tmp/pip-KY7EFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:23 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)) 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:23 INFO - Running setup.py (path:/tmp/pip-EnFqNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:23 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)) 04:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:23 INFO - Running setup.py (path:/tmp/pip-JaE2N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:24 INFO - Running setup.py (path:/tmp/pip-gotUr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:24 INFO - Running setup.py (path:/tmp/pip-POouF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:24 INFO - Running setup.py (path:/tmp/pip-_aYR9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:24 INFO - Running setup.py (path:/tmp/pip-d4_a_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:24 INFO - Running setup.py (path:/tmp/pip-bn91zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:24 INFO - Running setup.py (path:/tmp/pip-Hk_oD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:24 INFO - Running setup.py (path:/tmp/pip-BU7gNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:24 INFO - Running setup.py (path:/tmp/pip-iAIaTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:24 INFO - Running setup.py (path:/tmp/pip-DUol96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:24 INFO - Running setup.py (path:/tmp/pip-wPkEO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:24 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)) 04:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:24 INFO - Running setup.py (path:/tmp/pip-axHnPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:24 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)) 04:02:24 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)) 04:02:24 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)) 04:02:24 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)) 04:02:24 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)) 04:02:24 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)) 04:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:26 INFO - Downloading blessings-1.6.tar.gz 04:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:26 INFO - Installing collected packages: blessings 04:02:26 INFO - Running setup.py install for blessings 04:02:26 INFO - Successfully installed blessings 04:02:26 INFO - Cleaning up... 04:02:26 INFO - Return code: 0 04:02:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:27 INFO - Reading from file tmpfile_stdout 04:02:27 INFO - Current package versions: 04:02:27 INFO - argparse == 1.2.1 04:02:27 INFO - blessings == 1.6 04:02:27 INFO - blobuploader == 1.2.4 04:02:27 INFO - docopt == 0.6.1 04:02:27 INFO - functools32 == 3.2.3-2 04:02:27 INFO - jsonschema == 2.5.1 04:02:27 INFO - manifestparser == 1.1 04:02:27 INFO - mozInstall == 1.12 04:02:27 INFO - mozcrash == 0.17 04:02:27 INFO - mozdebug == 0.1 04:02:27 INFO - mozdevice == 0.48 04:02:27 INFO - mozfile == 1.2 04:02:27 INFO - mozhttpd == 0.7 04:02:27 INFO - mozinfo == 0.9 04:02:27 INFO - mozleak == 0.1 04:02:27 INFO - mozlog == 3.4 04:02:27 INFO - moznetwork == 0.27 04:02:27 INFO - mozprocess == 0.23 04:02:27 INFO - mozprofile == 0.28 04:02:27 INFO - mozrunner == 6.12 04:02:27 INFO - mozscreenshot == 0.1 04:02:27 INFO - mozsystemmonitor == 0.3 04:02:27 INFO - moztest == 0.7 04:02:27 INFO - mozversion == 1.4 04:02:27 INFO - psutil == 3.1.1 04:02:27 INFO - requests == 1.2.3 04:02:27 INFO - wsgiref == 0.1.2 04:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 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)) 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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 0x7f34c583df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Running post-action listener: _resource_record_post_action 04:02:27 INFO - Running post-action listener: _start_resource_monitoring 04:02:27 INFO - Starting resource monitoring. 04:02:27 INFO - [mozharness: 2016-09-25 11:02:27.655111Z] Finished create-virtualenv step (success) 04:02:27 INFO - [mozharness: 2016-09-25 11:02:27.655565Z] Running install step. 04:02:27 INFO - Running pre-action listener: _resource_record_pre_action 04:02:27 INFO - Running main action method: install 04:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:27 INFO - Reading from file tmpfile_stdout 04:02:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:27 INFO - Reading from file tmpfile_stdout 04:02:27 INFO - Output received: 04:02:27 INFO - Usage: mozinstall [options] installer 04:02:27 INFO - Options: 04:02:27 INFO - -h, --help show this help message and exit 04:02:27 INFO - -d DEST, --destination=DEST 04:02:27 INFO - Directory to install application into. [default: 04:02:27 INFO - "/builds/slave/test"] 04:02:27 INFO - --app=APP Application being installed. [default: firefox] 04:02:27 INFO - mkdir: /builds/slave/test/build/application 04:02:27 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'] 04:02:27 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 04:02:43 INFO - Reading from file tmpfile_stdout 04:02:43 INFO - Output received: 04:02:43 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:43 INFO - Running post-action listener: _resource_record_post_action 04:02:43 INFO - [mozharness: 2016-09-25 11:02:43.910027Z] Finished install step (success) 04:02:43 INFO - [mozharness: 2016-09-25 11:02:43.910272Z] Running run-tests step. 04:02:43 INFO - Running pre-action listener: _resource_record_pre_action 04:02:43 INFO - Running main action method: run_tests 04:02:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:43 INFO - Python 2.7.3 04:02:43 INFO - Return code: 0 04:02:43 INFO - grabbing minidump binary from tooltool 04:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:43 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 0x16b4f60>, '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 0x16b5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:43 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 04:02:43 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 04:02:43 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 04:02:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:44 INFO - Return code: 0 04:02:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:44 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/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:02:44 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/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 04:02:44 INFO - Using env: {'DISPLAY': ':0', 04:02:44 INFO - 'HOME': '/home/cltbld', 04:02:44 INFO - 'LANG': 'en_US.UTF-8', 04:02:44 INFO - 'LANGUAGE': 'en_US:en', 04:02:44 INFO - 'LOGNAME': 'cltbld', 04:02:44 INFO - 'MAIL': '/var/mail/cltbld', 04:02:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:44 INFO - 'MOZ_NO_REMOTE': '1', 04:02:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:44 INFO - 'NO_EM_RESTART': '1', 04:02:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:44 INFO - 'PWD': '/builds/slave/test', 04:02:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:44 INFO - 'SHELL': '/bin/bash', 04:02:44 INFO - 'SHLVL': '1', 04:02:44 INFO - 'TERM': 'linux', 04:02:44 INFO - 'TMOUT': '86400', 04:02:44 INFO - 'USER': 'cltbld', 04:02:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635', 04:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:44 INFO - '_': '/tools/buildbot/bin/python'} 04:02:44 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/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 04:02:44 INFO - mozversion application_buildid: 20160925004010 04:02:44 INFO - mozversion application_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 04:02:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:02:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:44 INFO - mozversion application_name: Firefox 04:02:44 INFO - mozversion application_remotingname: firefox-dev 04:02:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:02:44 INFO - mozversion application_vendor: Mozilla 04:02:44 INFO - mozversion application_version: 51.0a2 04:02:44 INFO - mozversion platform_buildid: 20160925004010 04:02:44 INFO - mozversion platform_changeset: 1fee8de1111fdcc6fb5d95d4afef92c913fc87f2 04:02:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:02:44 INFO - mozversion platform_version: 51.0a2 04:02:44 INFO - using testdate: 1474801364 04:02:44 INFO - actual date: 1474801364 04:02:44 INFO - starting webserver on 'localhost:50554' 04:02:44 INFO - SUITE-START | Running 2 tests 04:02:44 INFO - TEST-START | dromaeo_css 04:02:44 INFO - operating with platform_type : linux_ 04:02:44 INFO - Initialising browser for dromaeo_css test... 04:02:44 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGJkA5/profile http://localhost:50554/getInfo.html) 04:02:48 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 04:02:48 INFO - PROCESS | 1637 | colorDepth:24 04:02:48 INFO - PROCESS | 1637 | Browser inner width/height: 1024/697 04:02:48 INFO - PROCESS | 1637 | __metrics 04:02:49 INFO - PROCESS | 1637 | 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" 04:02:49 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:02:49 INFO - PROCESS | 1637 | console.error: PushService: 04:02:49 INFO - PROCESS | 1637 | stateChangeProcessEnqueue: Error transitioning state 04:02:49 INFO - PROCESS | 1637 | UnknownError 04:02:50 INFO - TEST-INFO | 1637: exit 0 04:02:50 INFO - Browser initialized. 04:02:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:50 INFO - TEST-INFO | started process 1731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGJkA5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:01 INFO - PROCESS | 1731 | RSS: Main: 144396288 04:03:01 INFO - PROCESS | 1731 | 04:03:53 INFO - PROCESS | 1731 | 1474801433076 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] 04:06:02 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50554/tests/dromaeo/cssquery-ext.html) 04:06:03 INFO - PROCESS | 1731 | RSS: Main: 243695616 04:06:03 INFO - PROCESS | 1731 | 04:09:05 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-ext.html (next: http://localhost:50554/tests/dromaeo/cssquery-jquery.html) 04:09:06 INFO - PROCESS | 1731 | RSS: Main: 238555136 04:09:06 INFO - PROCESS | 1731 | 04:12:08 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50554/tests/dromaeo/cssquery-mootools.html) 04:12:08 INFO - PROCESS | 1731 | RSS: Main: 225787904 04:12:08 INFO - PROCESS | 1731 | 04:15:10 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50554/tests/dromaeo/cssquery-prototype.html) 04:15:11 INFO - PROCESS | 1731 | RSS: Main: 216387584 04:15:11 INFO - PROCESS | 1731 | 04:18:13 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50554/tests/dromaeo/cssquery-yui.html) 04:18:14 INFO - PROCESS | 1731 | RSS: Main: 176914432 04:18:14 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | Cycle 1(1): loaded http://localhost:50554/tests/dromaeo/cssquery-yui.html (next: http://localhost:50554/tests/dromaeo/cssquery-dojo.html) 04:21:17 INFO - PROCESS | 1731 | RSS: Main: 262057984 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | __start_tp_report 04:21:17 INFO - PROCESS | 1731 | _x_x_mozilla_page_load 04:21:17 INFO - PROCESS | 1731 | _x_x_mozilla_page_load_details 04:21:17 INFO - PROCESS | 1731 | |i|pagename|runs| 04:21:17 INFO - PROCESS | 1731 | |0;dojo.html;3120.563121163037;3145.1350878508415;3163.604549431321;3178.459661857484;3188.0276515662713;5603.131514615231;5710.914336284949;5742.196092547037;5742.310922689273;5751.396103409139;5818.941810581893;5873.676947767871;5874.618149820259;5892.705364731768;5894.469497745202;5285.577153827704;5291.100512912814;5319.388270348902;5333.786648534074;5370.677759334433;5082.161443361841;5369.114096174127;5381.757820898049;5385;5413.404525502192;5089.287499750019;5203.245529398235;5231.790728370861;5263.631545791796;5282.762275697583;5227.4511176326505;5254.553362964152;5258.474152584749;5353.973230133864;5354.491323324317;5186.40356359016;5227.032998895216;5291.259223708684;5303.310569625963;5316.12283973144;5536.889262214733;5585.972070139664;5586.13414920688;5624.3531993820825;5657.094864821609;6095.024796032613;6114.388561143895;6127.908081378783;6223.471004964584;6226.066090086478;6187.286793828701;6253.812385628438;6254.46837018854;6265.9060114097865;6268.373162683741;5531.640443371168;5560.638558493685;5600.467955544217;5620.297462817148;5634;6196.783112591038;6220.409061139185;6229.96885015572;6234.37656234382;6241.625502469867;5974.3428222895445;5986.191864098378;5987.880242395127;5993.190919225849;5995.250593675791;5868.530517558585;5909;6025.879482410327;6049.818505444844;6069.02895536712;6116.698197749747;6118.708726356358;6120.292657642384;6128.422616821576;6139.6009259398;6118.969405152946;6134.681043575652;6139.6009259398;6145.293291271561;6147.877042459215;4577.702449340783;4586.839460618862;4671.976640116778;4696.2955556666775;4712.858614241578;4182.790860457026;4190.664746820247;4194.790260486963;4208.116295577963;4215.325547912319;5889.469947704727;5894.440028197314;5902.498287645598;5906.468417842415;5911;5987.43119403656;6034.1853849730605;6130.2146971548445;6252.218472690914;6254.655993920287;5804.88390232193;5934.7922822701;5957.642541447527;5979.521638268928;5988.28140623128;5230.529252367305;5233.058049551041;5236.554892834151;5237.895242095136;5241.9737901310245;6167.691615419211;6221.688915554295;6417.101605775195;6426.74293028283;6496.317886621931;6115.694215289307;6128.992047069418;6133.457080270946;6234.220722409699;6237.656928868956;6436.195475565554;6439.8068057958335;6440.905046142073;6442.387973142544;6459.644719540471;5782.2483077199695;6130.754769809158;6132.846678833065;6138.232720909887;6144.078388241799;5968.970155149196;6032.426919442646;6041.214642096499;6066;6158.414950579688;6005.939940600538;6007.399260074132;6012.248468941382;6015.0676645120075;6023.548233882389;6001.7299221536005;6004.129401236709;6008.939910601013;6012.789552365646;6015.187949626745;5755.510781583613;5873.119032145212;5951.880962380815;5981.043033114681;5984.700764961647;6114.938850611437;6142.201513803177;6162.845928851814;6169.722362493789;6175.320714721287;5772.769089236552;6022.2171117754415;6032.366601506954;6034.607750496204;6070.301915279622 04:21:17 INFO - PROCESS | 1731 | |1;ext.html;586.8298193523879;628.6479571439991;639.4947991087041;659.3340725866873;659.7361055577768;35345.293094138135;45933.31100033498;46581.83545411362;46617.53382466175;46619.06761864769;49105.50894491054;49517.75241123798;49604.50395496044;49643.25535116976;49662.50337496624;8659.956700216522;9325.626974920995;9504.524773761319;9514.238860891111;9516.904830951671;8529.488230706178;11152.944235278812;11411.54353825846;11413.086953043736;11838.822417663741;11528.135389845753;11595.826062609067;11610.941945290304;11615.709607259843;11623.593174238904;8707.172818582225;8896.243819275369;11232.606858759986;11408.657740267805;11501;10947.34315941046;11341.943290283578;11343.092552595772;11347.092232621371;11347.262427942158;46780.53219467796;46821.531784682054;47048.823779405444;47137;47158.52841471576;3799.3161230978412;3831.501904752364;3865.188310454808;3906.687465002821;3967.900802479961;30958.84520577405;31020.8448957756;31249;31514.52728209079;31917.680823191702;4675.742834144121;4726.858194254178;4770.642201834877;4783.641226907961;4861.829835955725;262824;265259;266882;386431.9999999972;386910;63546;64249.35750642527;64309.67845160744;64363.67818160879;64400.35599643944;40426.79786601048;41187.382189267184;41493.88795840324;43757;43848;18475.90762046208;18732.531686707942;18742.906285468485;18761.624767504574;18762.155702993125;13231;13615.795763063563;14017.85982140186;14185.219812910389;14327.78508322355;20365;21353.893230533748;21366.35900922975;21413.46466338354;21468.570628587342;7429.962850185714;7475.8504829903095;7587.355074818592;7629.54222746637;7711.961440192763;989.618996686281;1068.519429659115;1069.6951368859839;1071.4267866691282;1149.0692539043403;35007.64992350095;35376.932317987084;35919;35978.64021359805;35984;1115.6206889657556;1134.432783608196;1171.9238249513755;1189.482575079843;1234.8456442944632;16558.254878530493;17220.655586888442;17349.7397539037;17391.56521086983;17514.361356711175;638409;644613;644820;645521;645774;62101.37898621046;62661.37338626647;62699;62809;62840;1333.2800287844454;1374.1342953939154;1381.3645722967547;1424.5655075202162;1451.0640636789212;33429.33141337111;35859.462108068925;35955.64044359523;35994.28011439704;36016;53026;53959.460405395446;54024;54035.56839942133;54071.188932166835;455323;458872;460789;462113;462860;30952;31148.68851311458;31227.68772312248;32033.67966320307;32924.1768955778;51659.741701291256;51730.22404663858;52304.47695522996;52519;52593.7370313146;43534.78232608816;44396.55603443924;44844.32733509065;44867;46069;43984.24063037443;45003.77498112489;45117.32324015077;45409.31886021778;46334.768326158155;44249.55750442454;45170.096598068514;45435.545644543134;45500.31749523826;45612.77193614011;37497.6250237505;39870.80064599658;40441;41294.38058429186;41651;30083;30128.69871301259;30490.847545762128;30540;30561.23596910095 04:21:17 INFO - PROCESS | 1731 | |2;jquery.html;400.6338386103388;434.8499767580185;434.9499807522134;443.4039936118082;452.36216934122916;17143.399981000668;19470.90264548677;20604.278850240225;21215.893920530416;21425.892870535627;19867.503312417197;20538.383848484533;20629.587408251828;20721;20747.273845415413;5829.242198514187;5844.064949608063;6091.634501929899;6096.329403765582;6096.817095487142;5934.050551911695;5986.311574168983;6009.609375390607;6018.247719035121;6026.8493287667725;5769.076947688371;5939.495142912836;5982.970085149568;5995.940040599604;5999.970000150015;5956.821295361146;5969.044952807551;5992.43071908168;5996.16053752475;5996.19051428056;5210.400803907562;5388.407275199725;5409.161579955074;5413.621046526745;5417;22223.22218722353;23002.19492317761;23205;24119;24154.154604588755;2463.728989811137;2473.431110844516;2529.2285852814884;2789.4421115776927;2833.1500549835173;15318.617034574114;15521.301541430663;16319;16803.243854026477;16990.320387184496;2071.7721050684413;2085.958280834375;2152.2144417287577;2167.5881582499433;2214.833887458431;73525.6323718378;94610.0538994615;96738.03261967361;97242.51378743132;112739;15084.321205545557;18277.725834112498;19313.806861931484;19473.805261947484;19864.205431782855;29359.412811743645;29375.85312073426;29407.411851762845;29439.705602944126;29506.409871802443;10578.57685692579;10622.415767132727;10768.838467422995;10843;11046.889531104585;9100.726978190665;9184.173424391836;9201.723948281562;9362.391444556082;9366.765830854147;9203;9718.854217186748;9802.313838031268;9825.459599722084;9901.851472227921;3595.5146055282726;3617.855285788539;3658.2683463307444;3669.614690457517;3734.402495600691;938.2587755673078;1024.52871679027;1030.1552726763982;1042.7341028037802;1051.8474821151044;20034.799652003585;20276.594468110554;20282.151905022045;20577.279795207396;20670.379888603064;1032.780861776179;1040.287403128844;1061.6761887624348;1066.4987455895716;1110.6168371911679;10652.201084918663;10693.251472397013;11193.94403027996;11202.719932001764;11263.380514071805;456356;497162;503912;504564;531864;98157;102438;103087;105611;107137;1070.678796361104;1080.6379862746069;1104.536094840153;1108.8225883858545;1115.6931843743037;17684.91157544204;17906.5523361917;18093.36673216431;18164.72752908734;18645.347412840485;32880.272433982595;36394;40395.79802100971;40665.98335041648;43764.781176093915;54594.72702636461;57228.71385643045;59121.70439147777;59697.70151149217;60360.69819650874;8459.873101903599;8512.659493620185;8522.318214542698;8852.114788521096;8957.641694332153;11948.522059117538;13386.732265354443;13577.389017494039;13585.728285434037;13671.931640341734;11700.47347869365;11853;11900.821487677866;12033.398330083635;12249.510019599116;5602.13166959122;9940.254480913816;11471.311721296748;11519.596814111466;11971;11261.66215013551;11774.587889424172;11924.165308428674;11931.284122952651;12031.518739250332;8520.403571750167;8628.22345988864;8716.43343182691;8726.324744652971;9171.128742769426;10575.947120264349;11623.6512904613;11904.880951190724;12010;12189.939050304693 04:21:17 INFO - PROCESS | 1731 | |3;mootools.html;1526.4275896538795;1560.8595226429622;1745.5199820049486;1832.3953095478494;1884.8042031033856;8156;8430.620622072007;9225.261979041668;9948.701538953834;9949;9310.95344523278;9619.519024048805;9642.95178524108;9917.950410247939;9928.503574821267;2588.2623452316093;2632.9605055924176;2635.5651317532584;2635.736426357368;2636.393629465224;2220.889555222389;2296.2881506732965;2437.3297343230574;2524.507720994407;2587.1591732686857;2536.809739269553;2571.4214301782044;2571.8842652080702;2573.6010918307597;2577.4716183182495;2471.9876400618064;2473.789727873133;2564.512742578904;2567.358160459885;2570.6658134442405;2485.3413845331;2505.060602274147;2523.041244327162;2535.6069809179608;2538.530371881208;9681.225501959827;9792.265580081523;9792.412455252637;9797.706068817946;9803;5802.622829516068;5942.821715348547;5956.344802071769;5956.493698035672;5983.431574000463;3643.307771523402;3716.776993380379;3737.0470530014945;3745.4756334113245;3758.530183727034;1288.2463758701172;1297.1503665099376;1345.3542299696103;1364.733876894006;1389.0554422992361;13762.449502019907;13815.792763108562;13817.861821381757;13841.792373114513;13866.168029918137;5098.107831129538;5176.948230517722;5314.335708036496;5365.812196573179;5402.8919421611345;11639.185257031926;11653.88346116528;11664.125190610737;11667.241629294238;11671.416429178507;5952.166696662471;5952.166696662471;5952.345242023374;5955.34491205967;5958.731857066442;5363.624546281723;5364.275822763877;5394.568434525228;5472.808451704172;5480.561555075585;4477.104579084196;4510.594046535827;4565.474970378383;4663.976680116578;4752.28715692642;1285.4151361130664;1339.5043833781563;1400;1450.557579938108;1451.078565111162;996.8654231678776;1008.0826447932346;1018.9439580823126;1031.2111234905303;1031.9896801032044;6258.561900667;6406.167198264289;6410.61536307823;6420.0690899819265;6459.483241340681;993.3741742702051;1009.9798004039878;1014.8224060789332;1053.0943388685723;1082.3451811653993;4387.078713470143;4389.078293558388;4424.80088396023;4448.243798554254;4491.236489796743;12020.579279725167;12257.632271031705;12385.380730963416;12416.068794840423;12423.565175218824;12246.265224086404;12327.198732082386;12331.198472099284;12342.876571234352;12350;8623.525706086226;8930.821383572293;8950.641974320954;9180.127887850776;9189.081091890892;6417.39034791694;6508.674566271762;6535.869282614226;6679.532432729857;6768.120144381396;11107.222494425636;11337.886621133683;11448.427578621202;11503.367314797766;11613.76772464563;11494.482748276181;11573.537058517564;11606.70983225426;11612.76774464489;11620.477078531656;7932.960335198287;8021.157778433414;8056.154103819014;8062.072861620989;8461.40770146084;9091.818163636823;9138.08619138081;9219.49292788903;9230.584623692084;9234.215091717278;8231.547264900488;8342.29090527312;8421.536815475207;8576.785580360542;8585.840911476871;7970.4819186752675;8016.6392512335915;8139.633716482891;8195.95902020486;8243;7287.708491660274;7342.19235884063;7392.593407362647;7395.778126656209;7467.887981680171;5417.539509141609;5497.5601951842955;5568.888622227614;5636.098224284095;5660.15097735343;5432.592555558428;5489.917651235314;5753.798617048383;5806;5837.883242335214 04:21:17 INFO - PROCESS | 1731 | |4;prototype.html;347.7374582190446;351.3026642115401;353.14891112419065;356.04934824019864;358.86542546545047;5599.496045355917;5626.240457538231;5644.491995720385;5648.6893220872835;5680.147977803332;5224.738763061841;5312.92030619541;5412.4587541245855;5455.881544283422;5549.19536667183;4318.740875547477;4319.719218250803;4324.22164010478;4331.8087525930305;4339.110482351126;4357.498887627916;4359.280718681413;4359.367891655708;4368.759718215497;4373.890652733691;4133.359329303963;4333.349997500384;4333.718308309965;4334.934975975363;4356.7821608919585;4330.437043184366;4331.523532411432;4334.45819272591;4342.913141737164;4346.587074227943;3839.059430439532;3849.538055433338;3850.8074596270076;3852.2295540891932;3872.1481274119647;5286.180642000496;5422.240886275925;5448.945510544883;5463.262459567947;5492.368377636583;4997.350344455198;5003.974980125113;5008.649394542384;5014.2979982802435;5016.548510634024;5807.157962095514;5813.912791308134;5823.708814559255;5835.212246346731;5858.589898707092;4072.5927407259333;4193.790310484464;4235.428217190671;4242.851500197509;4247.299195632717;5995.130706047598;6024.819255422344;6037.667928263943;6047.123167140784;6063.969125248718;4235.458724765178;4237.978810105929;4253.532111467736;4268.893277668083;4281.91436171281;4235.174141042467;4240.893977650583;4286;4301.827926882952;4335.934960975588;4896.436909755353;4900.94629654626;4903.4606193318705;4909.975450122726;4910.189818679878;5829.766809327664;5840.094785308284;5845.795397161079;5861.827634473122;5877.5591830612875;1407.6480879780056;1440.2006886178062;1462.8902832287622;1503.5639664497173;1512.8351169599348;986.1568359052907;1009.4296722351847;1011.367895065584;1012.1093437774712;1018.8267994440963;5455.918161227585;5583.357913839879;5587.3015873015875;5595.776168953278;5605.159226116115;5798.217240672455;5834.854128646818;5845.678487683218;5849.239598852122;5869.589128760946;5323.574114070865;5551.167324901297;5600.663960162403;5604.327480702342;5625.846701426198;3110.9889285981694;3127.2807254331633;3127.8592463339205;3131.5146152346424;3136.764742644311;6087.421694938974;6106.114613381035;6108.144859719554;6118.877622447526;6125.479334256549;5788.479036886701;5959.22530071088;6002.919474494633;6017.969910150508;6021.638701677914;6019.488343490765;6036.426539478743;6059.242594675666;6103.6032657877095;6123.510119190365;5689.640625542794;5899.233099697012;5930.881382372242;5933.101407549542;5951.583389162717;5848.912266316093;5851.473367396955;5855.853603659943;5861.853453663693;5869.647821130746;5971.552133589911;6140.5701600887505;6141.539384546088;6142.662153581596;6146.416090471398;4242.660587152958;4258.254805409103;4264.189803937242;4269.615734583902;4278.251306021371;5905.8228253150755;5912.438318359749;5928.525717942468;5962.344142144448;5985.610935289193;5607.859803504782;5694.487496125203;5787.771707892408;5858.334457821766;5891.911621325769;5817.945578571284;5824.970875145597;5836.24128863262;5863.589548731547;5866.442687944638;5567.415421380697;5732.455416735404;5768.7404066817935;5805.303363596396;5849.853753656193;5856.385079566755;5862.237909071793;5867.618604790675;5875.059990401515;5889.411058894077;5600.887982240414;5729.9713501432225;5753.597248192586;5757.740901659352;5799.3040835100055 04:21:17 INFO - PROCESS | 1731 | |5;yui.html;807.3984881263459;813.5810057820222;815.7226542975391;900.5407242306421;956.2015716876406;16135;17330.913345433288;17331.566710832234;17354.652906941854;17390.82609173908;11396;14942.10347379158;14977.326020329085;15007.549773506813;15083.170425626586;716.8458781362019;855.1875718067861;884.6638277454558;890.5947793753827;891.3003292415456;876.2989608313355;876.3471213945587;877.7322916510494;877.903430622631;878.7627340618029;765.877459606463;935.8034812689309;936.3398803843274;937.8265020971108;938.3478482454697;779.9025121859768;786.3473317146783;786.5909726941986;893.6380765789866;910.5538286239761;679.2833560593572;680.4896327754184;681.0941447874316;681.5093132944272;682.2801943949181;15163.393464261417;15239.542813715607;15276.618084547865;15307.770383444256;15311.693766124727;14431.49489767853;14676.779848302283;14730.116193028452;14961.476348327866;14995.250237488191;12786.488540458371;12857;13064.889484393838;13116.6720831979;13256.072074954756;4539.455265368177;4569.360289559464;4622.306654001893;4632.8146874125;4656.790444430008;87868;88116.55941720314;90282;91986;92389.53805230997;12191.390430478441;12269.75460490803;12278.693032674077;12293.323867187211;12695.174813637084;23101.537969240857;23346.066157353514;23437.41406464852;23446.296611101694;23449.06203751831;8251.711190108317;8660.913390866011;8722.433041852386;8863.556822158995;9072.8639070414;4932.358793356912;5087.898242035212;5158.484151584887;5188.45521220274;5283.682979021271;3834.559025712023;3948.940765888514;4015.2371049501085;4018.7186896916937;4025.255327764373;671.9529632925648;674.5615350022524;691.3328637864385;713.564725517434;742.1613576658449;574.307958909513;584.4447774614133;664.7905909638448;730.9926900731031;768.8616049111214;10176.949115254525;10273.383596984206;10602.151827853753;10622.468876556295;10749.355038697704;652.3900153356627;687.556526040701;698.867215229115;709.6487238816716;717.7954283029312;4955.256711493233;5034.647574669738;5036.874078148002;5040.168372218616;5120.308758317654;128813;131065;133769;134223;135891;65263.67368163129;67464;68231;89536.10463895409;106993.9300606984;98862;101438;101873;104592;106248.46875765572;9751.75620609462;10069.345492542961;10116.494175291353;10210.591576336863;10215.591376344863;60955;61102.69448652728;61927;62454.687726561075;63737.68131159314;70600.64699676468;71429.64285178541;73276.63361683158;78420;83942.58028709817;11721.941390292994;12733.93633031866;12785.424655890693;12807.807882881578;12864.549740759028;14614.123152610877;14646.26768661584;14736.926315368355;14892.0320179188;15710.9214453927;14609.780853287422;14802.333894974536;15327.386904523693;15472.226388680296;15997.200139992721;13572.253526055767;14217.928910355382;14439.278036098363;14530.85469145295;14665;12504.499820007462;12606.810897836724;13461.125026873613;14594.124352538882;14873.628159296104;10729.89270107289;10954;11124.888751112385;11498.25261358009;11830.349330786888;10647.254692171473;10724.786717318902;10807.567697292021;10931.890681093088;10938.45307734626 04:21:17 INFO - PROCESS | 1731 | __end_tp_report 04:21:17 INFO - PROCESS | 1731 | __start_cc_report 04:21:17 INFO - PROCESS | 1731 | _x_x_mozilla_cycle_collect,888 04:21:17 INFO - PROCESS | 1731 | __end_cc_report 04:21:17 INFO - PROCESS | 1731 | __startTimestamp1474802477309__endTimestamp 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | ------- Summary: start ------- 04:21:17 INFO - PROCESS | 1731 | Number of tests: 6 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#0] dojo.html Cycles:165 Average:5709.16 Median:5979.52 stddev:668.48 (11.2%) stddev-sans-first:638.94 04:21:17 INFO - PROCESS | 1731 | Values: 3120.6 3145.1 3163.6 3178.5 3188.0 5603.1 5710.9 5742.2 5742.3 5751.4 5818.9 5873.7 5874.6 5892.7 5894.5 5285.6 5291.1 5319.4 5333.8 5370.7 5082.2 5369.1 5381.8 5385.0 5413.4 5089.3 5203.2 5231.8 5263.6 5282.8 5227.5 5254.6 5258.5 5354.0 5354.5 5186.4 5227.0 5291.3 5303.3 5316.1 5536.9 5586.0 5586.1 5624.4 5657.1 6095.0 6114.4 6127.9 6223.5 6226.1 6187.3 6253.8 6254.5 6265.9 6268.4 5531.6 5560.6 5600.5 5620.3 5634.0 6196.8 6220.4 6230.0 6234.4 6241.6 5974.3 5986.2 5987.9 5993.2 5995.3 5868.5 5909.0 6025.9 6049.8 6069.0 6116.7 6118.7 6120.3 6128.4 6139.6 6119.0 6134.7 6139.6 6145.3 6147.9 4577.7 4586.8 4672.0 4696.3 4712.9 4182.8 4190.7 4194.8 4208.1 4215.3 5889.5 5894.4 5902.5 5906.5 5911.0 5987.4 6034.2 6130.2 6252.2 6254.7 5804.9 5934.8 5957.6 5979.5 5988.3 5230.5 5233.1 5236.6 5237.9 5242.0 6167.7 6221.7 6417.1 6426.7 6496.3 6115.7 6129.0 6133.5 6234.2 6237.7 6436.2 6439.8 6440.9 6442.4 6459.6 5782.2 6130.8 6132.8 6138.2 6144.1 5969.0 6032.4 6041.2 6066.0 6158.4 6005.9 6007.4 6012.2 6015.1 6023.5 6001.7 6004.1 6008.9 6012.8 6015.2 5755.5 5873.1 5951.9 5981.0 5984.7 6114.9 6142.2 6162.8 6169.7 6175.3 5772.8 6022.2 6032.4 6034.6 6070.3 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#1] ext.html Cycles:180 Average:64379.31 Median:40814.19 stddev:131176.48 (321.4%) stddev-sans-first:131457.02 04:21:17 INFO - PROCESS | 1731 | Values: 586.8 628.6 639.5 659.3 659.7 35345.3 45933.3 46581.8 46617.5 46619.1 49105.5 49517.8 49604.5 49643.3 49662.5 8660.0 9325.6 9504.5 9514.2 9516.9 8529.5 11152.9 11411.5 11413.1 11838.8 11528.1 11595.8 11610.9 11615.7 11623.6 8707.2 8896.2 11232.6 11408.7 11501.0 10947.3 11341.9 11343.1 11347.1 11347.3 46780.5 46821.5 47048.8 47137.0 47158.5 3799.3 3831.5 3865.2 3906.7 3967.9 30958.8 31020.8 31249.0 31514.5 31917.7 4675.7 4726.9 4770.6 4783.6 4861.8 262824.0 265259.0 266882.0 386432.0 386910.0 63546.0 64249.4 64309.7 64363.7 64400.4 40426.8 41187.4 41493.9 43757.0 43848.0 18475.9 18732.5 18742.9 18761.6 18762.2 13231.0 13615.8 14017.9 14185.2 14327.8 20365.0 21353.9 21366.4 21413.5 21468.6 7430.0 7475.9 7587.4 7629.5 7712.0 989.6 1068.5 1069.7 1071.4 1149.1 35007.6 35376.9 35919.0 35978.6 35984.0 1115.6 1134.4 1171.9 1189.5 1234.8 16558.3 17220.7 17349.7 17391.6 17514.4 638409.0 644613.0 644820.0 645521.0 645774.0 62101.4 62661.4 62699.0 62809.0 62840.0 1333.3 1374.1 1381.4 1424.6 1451.1 33429.3 35859.5 35955.6 35994.3 36016.0 53026.0 53959.5 54024.0 54035.6 54071.2 455323.0 458872.0 460789.0 462113.0 462860.0 30952.0 31148.7 31227.7 32033.7 32924.2 51659.7 51730.2 52304.5 52519.0 52593.7 43534.8 44396.6 44844.3 44867.0 46069.0 43984.2 45003.8 45117.3 45409.3 46334.8 44249.6 45170.1 45435.5 45500.3 45612.8 37497.6 39870.8 40441.0 41294.4 41651.0 30083.0 30128.7 30490.8 30540.0 30561.2 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#2] jquery.html Cycles:180 Average:31068.99 Median:24136.58 stddev:82629.60 (342.3%) stddev-sans-first:82829.31 04:21:17 INFO - PROCESS | 1731 | Values: 400.6 434.8 434.9 443.4 452.4 17143.4 19470.9 20604.3 21215.9 21425.9 19867.5 20538.4 20629.6 20721.0 20747.3 5829.2 5844.1 6091.6 6096.3 6096.8 5934.1 5986.3 6009.6 6018.2 6026.8 5769.1 5939.5 5983.0 5995.9 6000.0 5956.8 5969.0 5992.4 5996.2 5996.2 5210.4 5388.4 5409.2 5413.6 5417.0 22223.2 23002.2 23205.0 24119.0 24154.2 2463.7 2473.4 2529.2 2789.4 2833.2 15318.6 15521.3 16319.0 16803.2 16990.3 2071.8 2086.0 2152.2 2167.6 2214.8 73525.6 94610.1 96738.0 97242.5 112739.0 15084.3 18277.7 19313.8 19473.8 19864.2 29359.4 29375.9 29407.4 29439.7 29506.4 10578.6 10622.4 10768.8 10843.0 11046.9 9100.7 9184.2 9201.7 9362.4 9366.8 9203.0 9718.9 9802.3 9825.5 9901.9 3595.5 3617.9 3658.3 3669.6 3734.4 938.3 1024.5 1030.2 1042.7 1051.8 20034.8 20276.6 20282.2 20577.3 20670.4 1032.8 1040.3 1061.7 1066.5 1110.6 10652.2 10693.3 11193.9 11202.7 11263.4 456356.0 497162.0 503912.0 504564.0 531864.0 98157.0 102438.0 103087.0 105611.0 107137.0 1070.7 1080.6 1104.5 1108.8 1115.7 17684.9 17906.6 18093.4 18164.7 18645.3 32880.3 36394.0 40395.8 40666.0 43764.8 54594.7 57228.7 59121.7 59697.7 60360.7 8459.9 8512.7 8522.3 8852.1 8957.6 11948.5 13386.7 13577.4 13585.7 13671.9 11700.5 11853.0 11900.8 12033.4 12249.5 5602.1 9940.3 11471.3 11519.6 11971.0 11261.7 11774.6 11924.2 11931.3 12031.5 8520.4 8628.2 8716.4 8726.3 9171.1 10575.9 11623.7 11904.9 12010.0 12189.9 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#3] mootools.html Cycles:180 Average:6402.97 Median:4614.73 stddev:3677.33 (79.7%) stddev-sans-first:3669.39 04:21:17 INFO - PROCESS | 1731 | Values: 1526.4 1560.9 1745.5 1832.4 1884.8 8156.0 8430.6 9225.3 9948.7 9949.0 9311.0 9619.5 9643.0 9918.0 9928.5 2588.3 2633.0 2635.6 2635.7 2636.4 2220.9 2296.3 2437.3 2524.5 2587.2 2536.8 2571.4 2571.9 2573.6 2577.5 2472.0 2473.8 2564.5 2567.4 2570.7 2485.3 2505.1 2523.0 2535.6 2538.5 9681.2 9792.3 9792.4 9797.7 9803.0 5802.6 5942.8 5956.3 5956.5 5983.4 3643.3 3716.8 3737.0 3745.5 3758.5 1288.2 1297.2 1345.4 1364.7 1389.1 13762.4 13815.8 13817.9 13841.8 13866.2 5098.1 5176.9 5314.3 5365.8 5402.9 11639.2 11653.9 11664.1 11667.2 11671.4 5952.2 5952.2 5952.3 5955.3 5958.7 5363.6 5364.3 5394.6 5472.8 5480.6 4477.1 4510.6 4565.5 4664.0 4752.3 1285.4 1339.5 1400.0 1450.6 1451.1 996.9 1008.1 1018.9 1031.2 1032.0 6258.6 6406.2 6410.6 6420.1 6459.5 993.4 1010.0 1014.8 1053.1 1082.3 4387.1 4389.1 4424.8 4448.2 4491.2 12020.6 12257.6 12385.4 12416.1 12423.6 12246.3 12327.2 12331.2 12342.9 12350.0 8623.5 8930.8 8950.6 9180.1 9189.1 6417.4 6508.7 6535.9 6679.5 6768.1 11107.2 11337.9 11448.4 11503.4 11613.8 11494.5 11573.5 11606.7 11612.8 11620.5 7933.0 8021.2 8056.2 8062.1 8461.4 9091.8 9138.1 9219.5 9230.6 9234.2 8231.5 8342.3 8421.5 8576.8 8585.8 7970.5 8016.6 8139.6 8196.0 8243.0 7287.7 7342.2 7392.6 7395.8 7467.9 5417.5 5497.6 5568.9 5636.1 5660.2 5432.6 5489.9 5753.8 5806.0 5837.9 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#4] prototype.html Cycles:180 Average:4889.66 Median:5597.64 stddev:1429.51 (25.5%) stddev-sans-first:1392.28 04:21:17 INFO - PROCESS | 1731 | Values: 347.7 351.3 353.1 356.0 358.9 5599.5 5626.2 5644.5 5648.7 5680.1 5224.7 5312.9 5412.5 5455.9 5549.2 4318.7 4319.7 4324.2 4331.8 4339.1 4357.5 4359.3 4359.4 4368.8 4373.9 4133.4 4333.3 4333.7 4334.9 4356.8 4330.4 4331.5 4334.5 4342.9 4346.6 3839.1 3849.5 3850.8 3852.2 3872.1 5286.2 5422.2 5448.9 5463.3 5492.4 4997.4 5004.0 5008.6 5014.3 5016.5 5807.2 5813.9 5823.7 5835.2 5858.6 4072.6 4193.8 4235.4 4242.9 4247.3 5995.1 6024.8 6037.7 6047.1 6064.0 4235.5 4238.0 4253.5 4268.9 4281.9 4235.2 4240.9 4286.0 4301.8 4335.9 4896.4 4900.9 4903.5 4910.0 4910.2 5829.8 5840.1 5845.8 5861.8 5877.6 1407.6 1440.2 1462.9 1503.6 1512.8 986.2 1009.4 1011.4 1012.1 1018.8 5455.9 5583.4 5587.3 5595.8 5605.2 5798.2 5834.9 5845.7 5849.2 5869.6 5323.6 5551.2 5600.7 5604.3 5625.8 3111.0 3127.3 3127.9 3131.5 3136.8 6087.4 6106.1 6108.1 6118.9 6125.5 5788.5 5959.2 6002.9 6018.0 6021.6 6019.5 6036.4 6059.2 6103.6 6123.5 5689.6 5899.2 5930.9 5933.1 5951.6 5848.9 5851.5 5855.9 5861.9 5869.6 5971.6 6140.6 6141.5 6142.7 6146.4 4242.7 4258.3 4264.2 4269.6 4278.3 5905.8 5912.4 5928.5 5962.3 5985.6 5607.9 5694.5 5787.8 5858.3 5891.9 5817.9 5825.0 5836.2 5863.6 5866.4 5567.4 5732.5 5768.7 5805.3 5849.9 5856.4 5862.2 5867.6 5875.1 5889.4 5600.9 5730.0 5753.6 5757.7 5799.3 04:21:17 INFO - PROCESS | 1731 | 04:21:17 INFO - PROCESS | 1731 | [#5] yui.html Cycles:180 Average:22233.89 Median:3982.09 stddev:32625.25 (819.3%) stddev-sans-first:32677.10 04:21:17 INFO - PROCESS | 1731 | Values: 807.4 813.6 815.7 900.5 956.2 16135.0 17330.9 17331.6 17354.7 17390.8 11396.0 14942.1 14977.3 15007.5 15083.2 716.8 855.2 884.7 890.6 891.3 876.3 876.3 877.7 877.9 878.8 765.9 935.8 936.3 937.8 938.3 779.9 786.3 786.6 893.6 910.6 679.3 680.5 681.1 681.5 682.3 15163.4 15239.5 15276.6 15307.8 15311.7 14431.5 14676.8 14730.1 14961.5 14995.3 12786.5 12857.0 13064.9 13116.7 13256.1 4539.5 4569.4 4622.3 4632.8 4656.8 87868.0 88116.6 90282.0 91986.0 92389.5 12191.4 12269.8 12278.7 12293.3 12695.2 23101.5 23346.1 23437.4 23446.3 23449.1 8251.7 8660.9 8722.4 8863.6 9072.9 4932.4 5087.9 5158.5 5188.5 5283.7 3834.6 3948.9 4015.2 4018.7 4025.3 672.0 674.6 691.3 713.6 742.2 574.3 584.4 664.8 731.0 768.9 10176.9 10273.4 10602.2 10622.5 10749.4 652.4 687.6 698.9 709.6 717.8 4955.3 5034.6 5036.9 5040.2 5120.3 128813.0 131065.0 133769.0 134223.0 135891.0 65263.7 67464.0 68231.0 89536.1 106993.9 98862.0 101438.0 101873.0 104592.0 106248.5 9751.8 10069.3 10116.5 10210.6 10215.6 60955.0 61102.7 61927.0 62454.7 63737.7 70600.6 71429.6 73276.6 78420.0 83942.6 11721.9 12733.9 12785.4 12807.8 12864.5 14614.1 14646.3 14736.9 14892.0 15710.9 14609.8 14802.3 15327.4 15472.2 15997.2 13572.3 14217.9 14439.3 14530.9 14665.0 12504.5 12606.8 13461.1 14594.1 14873.6 10729.9 10954.0 11124.9 11498.3 11830.3 10647.3 10724.8 10807.6 10931.9 10938.5 04:21:17 INFO - PROCESS | 1731 | -------- Summary: end -------- 04:21:17 INFO - PROCESS | 1731 | 04:21:18 INFO - TEST-INFO | 1731: exit 0 04:21:18 INFO - TEST-OK | dromaeo_css | took 1113841ms 04:21:18 INFO - TEST-START | kraken 04:21:18 INFO - operating with platform_type : linux_ 04:21:18 INFO - Initialising browser for kraken test... 04:21:18 INFO - TEST-INFO | started process 2049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4FeDs8/profile http://localhost:50554/getInfo.html) 04:21:22 INFO - PROCESS | 2049 | __metrics Screen width/height:1600/1200 04:21:22 INFO - PROCESS | 2049 | colorDepth:24 04:21:22 INFO - PROCESS | 2049 | Browser inner width/height: 1024/697 04:21:22 INFO - PROCESS | 2049 | __metrics 04:21:22 INFO - PROCESS | 2049 | 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" 04:21:22 INFO - PROCESS | 2049 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:21:23 INFO - PROCESS | 2049 | console.error: PushService: 04:21:23 INFO - PROCESS | 2049 | stateChangeProcessEnqueue: Error transitioning state 04:21:23 INFO - PROCESS | 2049 | UnknownError 04:21:23 INFO - TEST-INFO | 2049: exit 0 04:21:23 INFO - Browser initialized. 04:21:23 INFO - Running cycle 1/1 for kraken test... 04:21:23 INFO - TEST-INFO | started process 2139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4FeDs8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:35 INFO - PROCESS | 2139 | RSS: Main: 144781312 04:21:35 INFO - PROCESS | 2139 | 04:21:38 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50554/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:38 INFO - PROCESS | 2139 | RSS: Main: 186105856 04:21:38 INFO - PROCESS | 2139 | 04:21:41 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50554/tests/kraken/driver.html?testName=audio-dft) 04:21:42 INFO - PROCESS | 2139 | RSS: Main: 174895104 04:21:42 INFO - PROCESS | 2139 | 04:21:44 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50554/tests/kraken/driver.html?testName=audio-fft) 04:21:45 INFO - PROCESS | 2139 | RSS: Main: 266399744 04:21:45 INFO - PROCESS | 2139 | 04:21:47 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50554/tests/kraken/driver.html?testName=audio-oscillator) 04:21:48 INFO - PROCESS | 2139 | RSS: Main: 172744704 04:21:48 INFO - PROCESS | 2139 | 04:21:50 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:50 INFO - PROCESS | 2139 | RSS: Main: 174161920 04:21:50 INFO - PROCESS | 2139 | 04:21:53 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50554/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:54 INFO - PROCESS | 2139 | RSS: Main: 210259968 04:21:54 INFO - PROCESS | 2139 | 04:21:57 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50554/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:58 INFO - PROCESS | 2139 | RSS: Main: 209305600 04:21:58 INFO - PROCESS | 2139 | 04:22:01 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50554/tests/kraken/driver.html?testName=json-parse-financial) 04:22:01 INFO - PROCESS | 2139 | RSS: Main: 208891904 04:22:01 INFO - PROCESS | 2139 | 04:22:03 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:03 INFO - PROCESS | 2139 | RSS: Main: 171331584 04:22:03 INFO - PROCESS | 2139 | 04:22:05 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:06 INFO - PROCESS | 2139 | RSS: Main: 179511296 04:22:06 INFO - PROCESS | 2139 | 04:22:07 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:08 INFO - PROCESS | 2139 | RSS: Main: 183459840 04:22:08 INFO - PROCESS | 2139 | 04:22:11 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:11 INFO - PROCESS | 2139 | RSS: Main: 184139776 04:22:11 INFO - PROCESS | 2139 | 04:22:14 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:14 INFO - PROCESS | 2139 | RSS: Main: 182595584 04:22:14 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | Cycle 1(1): loaded http://localhost:50554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50554/tests/kraken/driver.html?testName=ai-astar) 04:22:16 INFO - PROCESS | 2139 | RSS: Main: 234074112 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | __start_tp_report 04:22:16 INFO - PROCESS | 2139 | _x_x_mozilla_page_load 04:22:16 INFO - PROCESS | 2139 | _x_x_mozilla_page_load_details 04:22:16 INFO - PROCESS | 2139 | |i|pagename|runs| 04:22:16 INFO - PROCESS | 2139 | |0;ai-astar;108;110;113;109;109;110;109;111;110;111 04:22:16 INFO - PROCESS | 2139 | |1;audio-beat-detection;157;127;116;157;119;119;117;116;155;121 04:22:16 INFO - PROCESS | 2139 | |2;audio-dft;162;162;161;160;163;161;160;161;160;160 04:22:16 INFO - PROCESS | 2139 | |3;audio-fft;75;76;77;117;76;76;75;76;98;75 04:22:16 INFO - PROCESS | 2139 | |4;audio-oscillator;82;83;126;81;81;80;106;83;82;108 04:22:16 INFO - PROCESS | 2139 | |5;imaging-gaussian-blur;117;116;116;117;117;116;116;117;117;117 04:22:16 INFO - PROCESS | 2139 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;145 04:22:16 INFO - PROCESS | 2139 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;96;96 04:22:16 INFO - PROCESS | 2139 | |8;json-parse-financial;51;51;48;48;50;48;50;49;49;49 04:22:16 INFO - PROCESS | 2139 | |9;json-stringify-tinderbox;58;59;59;59;58;58;58;59;59;59 04:22:16 INFO - PROCESS | 2139 | |10;stanford-crypto-aes;74;74;75;73;73;72;73;74;73;72 04:22:16 INFO - PROCESS | 2139 | |11;stanford-crypto-ccm;133;132;117;124;117;116;126;118;158;119 04:22:16 INFO - PROCESS | 2139 | |12;stanford-crypto-pbkdf2;150;150;149;153;153;153;151;148;150;150 04:22:16 INFO - PROCESS | 2139 | |13;stanford-crypto-sha256-iterative;62;62;62;62;61;66;61;62;64;61 04:22:16 INFO - PROCESS | 2139 | __end_tp_report 04:22:16 INFO - PROCESS | 2139 | __start_cc_report 04:22:16 INFO - PROCESS | 2139 | _x_x_mozilla_cycle_collect,1558 04:22:16 INFO - PROCESS | 2139 | __end_cc_report 04:22:16 INFO - PROCESS | 2139 | __startTimestamp1474802536846__endTimestamp 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | ------- Summary: start ------- 04:22:16 INFO - PROCESS | 2139 | Number of tests: 14 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.41 (1.3%) stddev-sans-first:1.30 04:22:16 INFO - PROCESS | 2139 | Values: 108.0 110.0 113.0 109.0 109.0 110.0 109.0 111.0 110.0 111.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:124.00 stddev:18.18 (14.7%) stddev-sans-first:16.54 04:22:16 INFO - PROCESS | 2139 | Values: 157.0 127.0 116.0 157.0 119.0 119.0 117.0 116.0 155.0 121.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 04:22:16 INFO - PROCESS | 2139 | Values: 162.0 162.0 161.0 160.0 163.0 161.0 160.0 161.0 160.0 160.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:14.13 (18.6%) stddev-sans-first:14.75 04:22:16 INFO - PROCESS | 2139 | Values: 75.0 76.0 77.0 117.0 76.0 76.0 75.0 76.0 98.0 75.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:81.50 stddev:16.16 (19.8%) stddev-sans-first:16.79 04:22:16 INFO - PROCESS | 2139 | Values: 82.0 83.0 126.0 81.0 81.0 80.0 106.0 83.0 82.0 108.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:22:16 INFO - PROCESS | 2139 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 04:22:16 INFO - PROCESS | 2139 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:22:16 INFO - PROCESS | 2139 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:1.16 (2.3%) stddev-sans-first:1.05 04:22:16 INFO - PROCESS | 2139 | Values: 51.0 51.0 48.0 48.0 50.0 48.0 50.0 49.0 49.0 49.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:22:16 INFO - PROCESS | 2139 | Values: 58.0 59.0 59.0 59.0 58.0 58.0 58.0 59.0 59.0 59.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 04:22:16 INFO - PROCESS | 2139 | Values: 74.0 74.0 75.0 73.0 73.0 72.0 73.0 74.0 73.0 72.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.00 stddev:12.86 (10.3%) stddev-sans-first:13.39 04:22:16 INFO - PROCESS | 2139 | Values: 133.0 132.0 117.0 124.0 117.0 116.0 126.0 118.0 158.0 119.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:150.50 stddev:1.77 (1.2%) stddev-sans-first:1.86 04:22:16 INFO - PROCESS | 2139 | Values: 150.0 150.0 149.0 153.0 153.0 153.0 151.0 148.0 150.0 150.0 04:22:16 INFO - PROCESS | 2139 | 04:22:16 INFO - PROCESS | 2139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.57 (2.5%) stddev-sans-first:1.66 04:22:16 INFO - PROCESS | 2139 | Values: 62.0 62.0 62.0 62.0 61.0 66.0 61.0 62.0 64.0 61.0 04:22:16 INFO - PROCESS | 2139 | -------- Summary: end -------- 04:22:16 INFO - PROCESS | 2139 | 04:22:17 INFO - TEST-INFO | 2139: exit 0 04:22:17 INFO - TEST-OK | kraken | took 59880ms 04:22:17 INFO - SUITE-END | took 1173s 04:22:18 INFO - Completed test suite (00:19:33) 04:22:18 INFO - javascript benchmark 04:22:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.563121163037, 3145.1350878508415, 3163.604549431321, 3178.459661857484, 3188.0276515662713, 5603.131514615231, 5710.914336284949, 5742.196092547037, 5742.310922689273, 5751.396103409139, 5818.941810581893, 5873.676947767871, 5874.618149820259, 5892.705364731768, 5894.469497745202, 5285.577153827704, 5291.100512912814, 5319.388270348902, 5333.786648534074, 5370.677759334433, 5082.161443361841, 5369.114096174127, 5381.757820898049, 5385.0, 5413.404525502192, 5089.287499750019, 5203.245529398235, 5231.790728370861, 5263.631545791796, 5282.762275697583, 5227.4511176326505, 5254.553362964152, 5258.474152584749, 5353.973230133864, 5354.491323324317, 5186.40356359016, 5227.032998895216, 5291.259223708684, 5303.310569625963, 5316.12283973144, 5536.889262214733, 5585.972070139664, 5586.13414920688, 5624.3531993820825, 5657.094864821609, 6095.024796032613, 6114.388561143895, 6127.908081378783, 6223.471004964584, 6226.066090086478, 6187.286793828701, 6253.812385628438, 6254.46837018854, 6265.9060114097865, 6268.373162683741, 5531.640443371168, 5560.638558493685, 5600.467955544217, 5620.297462817148, 5634.0, 6196.783112591038, 6220.409061139185, 6229.96885015572, 6234.37656234382, 6241.625502469867, 5974.3428222895445, 5986.191864098378, 5987.880242395127, 5993.190919225849, 5995.250593675791, 5868.530517558585, 5909.0, 6025.879482410327, 6049.818505444844, 6069.02895536712, 6116.698197749747, 6118.708726356358, 6120.292657642384, 6128.422616821576, 6139.6009259398, 6118.969405152946, 6134.681043575652, 6139.6009259398, 6145.293291271561, 6147.877042459215, 4577.702449340783, 4586.839460618862, 4671.976640116778, 4696.2955556666775, 4712.858614241578, 4182.790860457026, 4190.664746820247, 4194.790260486963, 4208.116295577963, 4215.325547912319, 5889.469947704727, 5894.440028197314, 5902.498287645598, 5906.468417842415, 5911.0, 5987.43119403656, 6034.1853849730605, 6130.2146971548445, 6252.218472690914, 6254.655993920287, 5804.88390232193, 5934.7922822701, 5957.642541447527, 5979.521638268928, 5988.28140623128, 5230.529252367305, 5233.058049551041, 5236.554892834151, 5237.895242095136, 5241.9737901310245, 6167.691615419211, 6221.688915554295, 6417.101605775195, 6426.74293028283, 6496.317886621931, 6115.694215289307, 6128.992047069418, 6133.457080270946, 6234.220722409699, 6237.656928868956, 6436.195475565554, 6439.8068057958335, 6440.905046142073, 6442.387973142544, 6459.644719540471, 5782.2483077199695, 6130.754769809158, 6132.846678833065, 6138.232720909887, 6144.078388241799, 5968.970155149196, 6032.426919442646, 6041.214642096499, 6066.0, 6158.414950579688, 6005.939940600538, 6007.399260074132, 6012.248468941382, 6015.0676645120075, 6023.548233882389, 6001.7299221536005, 6004.129401236709, 6008.939910601013, 6012.789552365646, 6015.187949626745, 5755.510781583613, 5873.119032145212, 5951.880962380815, 5981.043033114681, 5984.700764961647, 6114.938850611437, 6142.201513803177, 6162.845928851814, 6169.722362493789, 6175.320714721287, 5772.769089236552, 6022.2171117754415, 6032.366601506954, 6034.607750496204, 6070.301915279622], "value": 5661.51604384792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8298193523879, 628.6479571439991, 639.4947991087041, 659.3340725866873, 659.7361055577768, 35345.293094138135, 45933.31100033498, 46581.83545411362, 46617.53382466175, 46619.06761864769, 49105.50894491054, 49517.75241123798, 49604.50395496044, 49643.25535116976, 49662.50337496624, 8659.956700216522, 9325.626974920995, 9504.524773761319, 9514.238860891111, 9516.904830951671, 8529.488230706178, 11152.944235278812, 11411.54353825846, 11413.086953043736, 11838.822417663741, 11528.135389845753, 11595.826062609067, 11610.941945290304, 11615.709607259843, 11623.593174238904, 8707.172818582225, 8896.243819275369, 11232.606858759986, 11408.657740267805, 11501.0, 10947.34315941046, 11341.943290283578, 11343.092552595772, 11347.092232621371, 11347.262427942158, 46780.53219467796, 46821.531784682054, 47048.823779405444, 47137.0, 47158.52841471576, 3799.3161230978412, 3831.501904752364, 3865.188310454808, 3906.687465002821, 3967.900802479961, 30958.84520577405, 31020.8448957756, 31249.0, 31514.52728209079, 31917.680823191702, 4675.742834144121, 4726.858194254178, 4770.642201834877, 4783.641226907961, 4861.829835955725, 262824.0, 265259.0, 266882.0, 386431.9999999972, 386910.0, 63546.0, 64249.35750642527, 64309.67845160744, 64363.67818160879, 64400.35599643944, 40426.79786601048, 41187.382189267184, 41493.88795840324, 43757.0, 43848.0, 18475.90762046208, 18732.531686707942, 18742.906285468485, 18761.624767504574, 18762.155702993125, 13231.0, 13615.795763063563, 14017.85982140186, 14185.219812910389, 14327.78508322355, 20365.0, 21353.893230533748, 21366.35900922975, 21413.46466338354, 21468.570628587342, 7429.962850185714, 7475.8504829903095, 7587.355074818592, 7629.54222746637, 7711.961440192763, 989.618996686281, 1068.519429659115, 1069.6951368859839, 1071.4267866691282, 1149.0692539043403, 35007.64992350095, 35376.932317987084, 35919.0, 35978.64021359805, 35984.0, 1115.6206889657556, 1134.432783608196, 1171.9238249513755, 1189.482575079843, 1234.8456442944632, 16558.254878530493, 17220.655586888442, 17349.7397539037, 17391.56521086983, 17514.361356711175, 638409.0, 644613.0, 644820.0, 645521.0, 645774.0, 62101.37898621046, 62661.37338626647, 62699.0, 62809.0, 62840.0, 1333.2800287844454, 1374.1342953939154, 1381.3645722967547, 1424.5655075202162, 1451.0640636789212, 33429.33141337111, 35859.462108068925, 35955.64044359523, 35994.28011439704, 36016.0, 53026.0, 53959.460405395446, 54024.0, 54035.56839942133, 54071.188932166835, 455323.0, 458872.0, 460789.0, 462113.0, 462860.0, 30952.0, 31148.68851311458, 31227.68772312248, 32033.67966320307, 32924.1768955778, 51659.741701291256, 51730.22404663858, 52304.47695522996, 52519.0, 52593.7370313146, 43534.78232608816, 44396.55603443924, 44844.32733509065, 44867.0, 46069.0, 43984.24063037443, 45003.77498112489, 45117.32324015077, 45409.31886021778, 46334.768326158155, 44249.55750442454, 45170.096598068514, 45435.545644543134, 45500.31749523826, 45612.77193614011, 37497.6250237505, 39870.80064599658, 40441.0, 41294.38058429186, 41651.0, 30083.0, 30128.69871301259, 30490.847545762128, 30540.0, 30561.23596910095], "value": 21688.761645824008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.6338386103388, 434.8499767580185, 434.9499807522134, 443.4039936118082, 452.36216934122916, 17143.399981000668, 19470.90264548677, 20604.278850240225, 21215.893920530416, 21425.892870535627, 19867.503312417197, 20538.383848484533, 20629.587408251828, 20721.0, 20747.273845415413, 5829.242198514187, 5844.064949608063, 6091.634501929899, 6096.329403765582, 6096.817095487142, 5934.050551911695, 5986.311574168983, 6009.609375390607, 6018.247719035121, 6026.8493287667725, 5769.076947688371, 5939.495142912836, 5982.970085149568, 5995.940040599604, 5999.970000150015, 5956.821295361146, 5969.044952807551, 5992.43071908168, 5996.16053752475, 5996.19051428056, 5210.400803907562, 5388.407275199725, 5409.161579955074, 5413.621046526745, 5417.0, 22223.22218722353, 23002.19492317761, 23205.0, 24119.0, 24154.154604588755, 2463.728989811137, 2473.431110844516, 2529.2285852814884, 2789.4421115776927, 2833.1500549835173, 15318.617034574114, 15521.301541430663, 16319.0, 16803.243854026477, 16990.320387184496, 2071.7721050684413, 2085.958280834375, 2152.2144417287577, 2167.5881582499433, 2214.833887458431, 73525.6323718378, 94610.0538994615, 96738.03261967361, 97242.51378743132, 112739.0, 15084.321205545557, 18277.725834112498, 19313.806861931484, 19473.805261947484, 19864.205431782855, 29359.412811743645, 29375.85312073426, 29407.411851762845, 29439.705602944126, 29506.409871802443, 10578.57685692579, 10622.415767132727, 10768.838467422995, 10843.0, 11046.889531104585, 9100.726978190665, 9184.173424391836, 9201.723948281562, 9362.391444556082, 9366.765830854147, 9203.0, 9718.854217186748, 9802.313838031268, 9825.459599722084, 9901.851472227921, 3595.5146055282726, 3617.855285788539, 3658.2683463307444, 3669.614690457517, 3734.402495600691, 938.2587755673078, 1024.52871679027, 1030.1552726763982, 1042.7341028037802, 1051.8474821151044, 20034.799652003585, 20276.594468110554, 20282.151905022045, 20577.279795207396, 20670.379888603064, 1032.780861776179, 1040.287403128844, 1061.6761887624348, 1066.4987455895716, 1110.6168371911679, 10652.201084918663, 10693.251472397013, 11193.94403027996, 11202.719932001764, 11263.380514071805, 456356.0, 497162.0, 503912.0, 504564.0, 531864.0, 98157.0, 102438.0, 103087.0, 105611.0, 107137.0, 1070.678796361104, 1080.6379862746069, 1104.536094840153, 1108.8225883858545, 1115.6931843743037, 17684.91157544204, 17906.5523361917, 18093.36673216431, 18164.72752908734, 18645.347412840485, 32880.272433982595, 36394.0, 40395.79802100971, 40665.98335041648, 43764.781176093915, 54594.72702636461, 57228.71385643045, 59121.70439147777, 59697.70151149217, 60360.69819650874, 8459.873101903599, 8512.659493620185, 8522.318214542698, 8852.114788521096, 8957.641694332153, 11948.522059117538, 13386.732265354443, 13577.389017494039, 13585.728285434037, 13671.931640341734, 11700.47347869365, 11853.0, 11900.821487677866, 12033.398330083635, 12249.510019599116, 5602.13166959122, 9940.254480913816, 11471.311721296748, 11519.596814111466, 11971.0, 11261.66215013551, 11774.587889424172, 11924.165308428674, 11931.284122952651, 12031.518739250332, 8520.403571750167, 8628.22345988864, 8716.43343182691, 8726.324744652971, 9171.128742769426, 10575.947120264349, 11623.6512904613, 11904.880951190724, 12010.0, 12189.939050304693], "value": 10417.376943114503, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1526.4275896538795, 1560.8595226429622, 1745.5199820049486, 1832.3953095478494, 1884.8042031033856, 8156.0, 8430.620622072007, 9225.261979041668, 9948.701538953834, 9949.0, 9310.95344523278, 9619.519024048805, 9642.95178524108, 9917.950410247939, 9928.503574821267, 2588.2623452316093, 2632.9605055924176, 2635.5651317532584, 2635.736426357368, 2636.393629465224, 2220.889555222389, 2296.2881506732965, 2437.3297343230574, 2524.507720994407, 2587.1591732686857, 2536.809739269553, 2571.4214301782044, 2571.8842652080702, 2573.6010918307597, 2577.4716183182495, 2471.9876400618064, 2473.789727873133, 2564.512742578904, 2567.358160459885, 2570.6658134442405, 2485.3413845331, 2505.060602274147, 2523.041244327162, 2535.6069809179608, 2538.530371881208, 9681.225501959827, 9792.265580081523, 9792.412455252637, 9797.706068817946, 9803.0, 5802.622829516068, 5942.821715348547, 5956.344802071769, 5956.493698035672, 5983.431574000463, 3643.307771523402, 3716.776993380379, 3737.0470530014945, 3745.4756334113245, 3758.530183727034, 1288.2463758701172, 1297.1503665099376, 1345.3542299696103, 1364.733876894006, 1389.0554422992361, 13762.449502019907, 13815.792763108562, 13817.861821381757, 13841.792373114513, 13866.168029918137, 5098.107831129538, 5176.948230517722, 5314.335708036496, 5365.812196573179, 5402.8919421611345, 11639.185257031926, 11653.88346116528, 11664.125190610737, 11667.241629294238, 11671.416429178507, 5952.166696662471, 5952.166696662471, 5952.345242023374, 5955.34491205967, 5958.731857066442, 5363.624546281723, 5364.275822763877, 5394.568434525228, 5472.808451704172, 5480.561555075585, 4477.104579084196, 4510.594046535827, 4565.474970378383, 4663.976680116578, 4752.28715692642, 1285.4151361130664, 1339.5043833781563, 1400.0, 1450.557579938108, 1451.078565111162, 996.8654231678776, 1008.0826447932346, 1018.9439580823126, 1031.2111234905303, 1031.9896801032044, 6258.561900667, 6406.167198264289, 6410.61536307823, 6420.0690899819265, 6459.483241340681, 993.3741742702051, 1009.9798004039878, 1014.8224060789332, 1053.0943388685723, 1082.3451811653993, 4387.078713470143, 4389.078293558388, 4424.80088396023, 4448.243798554254, 4491.236489796743, 12020.579279725167, 12257.632271031705, 12385.380730963416, 12416.068794840423, 12423.565175218824, 12246.265224086404, 12327.198732082386, 12331.198472099284, 12342.876571234352, 12350.0, 8623.525706086226, 8930.821383572293, 8950.641974320954, 9180.127887850776, 9189.081091890892, 6417.39034791694, 6508.674566271762, 6535.869282614226, 6679.532432729857, 6768.120144381396, 11107.222494425636, 11337.886621133683, 11448.427578621202, 11503.367314797766, 11613.76772464563, 11494.482748276181, 11573.537058517564, 11606.70983225426, 11612.76774464489, 11620.477078531656, 7932.960335198287, 8021.157778433414, 8056.154103819014, 8062.072861620989, 8461.40770146084, 9091.818163636823, 9138.08619138081, 9219.49292788903, 9230.584623692084, 9234.215091717278, 8231.547264900488, 8342.29090527312, 8421.536815475207, 8576.785580360542, 8585.840911476871, 7970.4819186752675, 8016.6392512335915, 8139.633716482891, 8195.95902020486, 8243.0, 7287.708491660274, 7342.19235884063, 7392.593407362647, 7395.778126656209, 7467.887981680171, 5417.539509141609, 5497.5601951842955, 5568.888622227614, 5636.098224284095, 5660.15097735343, 5432.592555558428, 5489.917651235314, 5753.798617048383, 5806.0, 5837.883242335214], "value": 5113.916481151905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7374582190446, 351.3026642115401, 353.14891112419065, 356.04934824019864, 358.86542546545047, 5599.496045355917, 5626.240457538231, 5644.491995720385, 5648.6893220872835, 5680.147977803332, 5224.738763061841, 5312.92030619541, 5412.4587541245855, 5455.881544283422, 5549.19536667183, 4318.740875547477, 4319.719218250803, 4324.22164010478, 4331.8087525930305, 4339.110482351126, 4357.498887627916, 4359.280718681413, 4359.367891655708, 4368.759718215497, 4373.890652733691, 4133.359329303963, 4333.349997500384, 4333.718308309965, 4334.934975975363, 4356.7821608919585, 4330.437043184366, 4331.523532411432, 4334.45819272591, 4342.913141737164, 4346.587074227943, 3839.059430439532, 3849.538055433338, 3850.8074596270076, 3852.2295540891932, 3872.1481274119647, 5286.180642000496, 5422.240886275925, 5448.945510544883, 5463.262459567947, 5492.368377636583, 4997.350344455198, 5003.974980125113, 5008.649394542384, 5014.2979982802435, 5016.548510634024, 5807.157962095514, 5813.912791308134, 5823.708814559255, 5835.212246346731, 5858.589898707092, 4072.5927407259333, 4193.790310484464, 4235.428217190671, 4242.851500197509, 4247.299195632717, 5995.130706047598, 6024.819255422344, 6037.667928263943, 6047.123167140784, 6063.969125248718, 4235.458724765178, 4237.978810105929, 4253.532111467736, 4268.893277668083, 4281.91436171281, 4235.174141042467, 4240.893977650583, 4286.0, 4301.827926882952, 4335.934960975588, 4896.436909755353, 4900.94629654626, 4903.4606193318705, 4909.975450122726, 4910.189818679878, 5829.766809327664, 5840.094785308284, 5845.795397161079, 5861.827634473122, 5877.5591830612875, 1407.6480879780056, 1440.2006886178062, 1462.8902832287622, 1503.5639664497173, 1512.8351169599348, 986.1568359052907, 1009.4296722351847, 1011.367895065584, 1012.1093437774712, 1018.8267994440963, 5455.918161227585, 5583.357913839879, 5587.3015873015875, 5595.776168953278, 5605.159226116115, 5798.217240672455, 5834.854128646818, 5845.678487683218, 5849.239598852122, 5869.589128760946, 5323.574114070865, 5551.167324901297, 5600.663960162403, 5604.327480702342, 5625.846701426198, 3110.9889285981694, 3127.2807254331633, 3127.8592463339205, 3131.5146152346424, 3136.764742644311, 6087.421694938974, 6106.114613381035, 6108.144859719554, 6118.877622447526, 6125.479334256549, 5788.479036886701, 5959.22530071088, 6002.919474494633, 6017.969910150508, 6021.638701677914, 6019.488343490765, 6036.426539478743, 6059.242594675666, 6103.6032657877095, 6123.510119190365, 5689.640625542794, 5899.233099697012, 5930.881382372242, 5933.101407549542, 5951.583389162717, 5848.912266316093, 5851.473367396955, 5855.853603659943, 5861.853453663693, 5869.647821130746, 5971.552133589911, 6140.5701600887505, 6141.539384546088, 6142.662153581596, 6146.416090471398, 4242.660587152958, 4258.254805409103, 4264.189803937242, 4269.615734583902, 4278.251306021371, 5905.8228253150755, 5912.438318359749, 5928.525717942468, 5962.344142144448, 5985.610935289193, 5607.859803504782, 5694.487496125203, 5787.771707892408, 5858.334457821766, 5891.911621325769, 5817.945578571284, 5824.970875145597, 5836.24128863262, 5863.589548731547, 5866.442687944638, 5567.415421380697, 5732.455416735404, 5768.7404066817935, 5805.303363596396, 5849.853753656193, 5856.385079566755, 5862.237909071793, 5867.618604790675, 5875.059990401515, 5889.411058894077, 5600.887982240414, 5729.9713501432225, 5753.597248192586, 5757.740901659352, 5799.3040835100055], "value": 4435.528201325759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3984881263459, 813.5810057820222, 815.7226542975391, 900.5407242306421, 956.2015716876406, 16135.0, 17330.913345433288, 17331.566710832234, 17354.652906941854, 17390.82609173908, 11396.0, 14942.10347379158, 14977.326020329085, 15007.549773506813, 15083.170425626586, 716.8458781362019, 855.1875718067861, 884.6638277454558, 890.5947793753827, 891.3003292415456, 876.2989608313355, 876.3471213945587, 877.7322916510494, 877.903430622631, 878.7627340618029, 765.877459606463, 935.8034812689309, 936.3398803843274, 937.8265020971108, 938.3478482454697, 779.9025121859768, 786.3473317146783, 786.5909726941986, 893.6380765789866, 910.5538286239761, 679.2833560593572, 680.4896327754184, 681.0941447874316, 681.5093132944272, 682.2801943949181, 15163.393464261417, 15239.542813715607, 15276.618084547865, 15307.770383444256, 15311.693766124727, 14431.49489767853, 14676.779848302283, 14730.116193028452, 14961.476348327866, 14995.250237488191, 12786.488540458371, 12857.0, 13064.889484393838, 13116.6720831979, 13256.072074954756, 4539.455265368177, 4569.360289559464, 4622.306654001893, 4632.8146874125, 4656.790444430008, 87868.0, 88116.55941720314, 90282.0, 91986.0, 92389.53805230997, 12191.390430478441, 12269.75460490803, 12278.693032674077, 12293.323867187211, 12695.174813637084, 23101.537969240857, 23346.066157353514, 23437.41406464852, 23446.296611101694, 23449.06203751831, 8251.711190108317, 8660.913390866011, 8722.433041852386, 8863.556822158995, 9072.8639070414, 4932.358793356912, 5087.898242035212, 5158.484151584887, 5188.45521220274, 5283.682979021271, 3834.559025712023, 3948.940765888514, 4015.2371049501085, 4018.7186896916937, 4025.255327764373, 671.9529632925648, 674.5615350022524, 691.3328637864385, 713.564725517434, 742.1613576658449, 574.307958909513, 584.4447774614133, 664.7905909638448, 730.9926900731031, 768.8616049111214, 10176.949115254525, 10273.383596984206, 10602.151827853753, 10622.468876556295, 10749.355038697704, 652.3900153356627, 687.556526040701, 698.867215229115, 709.6487238816716, 717.7954283029312, 4955.256711493233, 5034.647574669738, 5036.874078148002, 5040.168372218616, 5120.308758317654, 128813.0, 131065.0, 133769.0, 134223.0, 135891.0, 65263.67368163129, 67464.0, 68231.0, 89536.10463895409, 106993.9300606984, 98862.0, 101438.0, 101873.0, 104592.0, 106248.46875765572, 9751.75620609462, 10069.345492542961, 10116.494175291353, 10210.591576336863, 10215.591376344863, 60955.0, 61102.69448652728, 61927.0, 62454.687726561075, 63737.68131159314, 70600.64699676468, 71429.64285178541, 73276.63361683158, 78420.0, 83942.58028709817, 11721.941390292994, 12733.93633031866, 12785.424655890693, 12807.807882881578, 12864.549740759028, 14614.123152610877, 14646.26768661584, 14736.926315368355, 14892.0320179188, 15710.9214453927, 14609.780853287422, 14802.333894974536, 15327.386904523693, 15472.226388680296, 15997.200139992721, 13572.253526055767, 14217.928910355382, 14439.278036098363, 14530.85469145295, 14665.0, 12504.499820007462, 12606.810897836724, 13461.125026873613, 14594.124352538882, 14873.628159296104, 10729.89270107289, 10954.0, 11124.888751112385, 11498.25261358009, 11830.349330786888, 10647.254692171473, 10724.786717318902, 10807.567697292021, 10931.890681093088, 10938.45307734626], "value": 7978.060294548018, "unit": "score"}], "name": "dromaeo_css", "value": 7835.99624332759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 113.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 116.0, 157.0, 119.0, 119.0, 117.0, 116.0, 155.0, 121.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 163.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 117.0, 76.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 81.0, 81.0, 80.0, 106.0, 83.0, 82.0, 108.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.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, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 48.0, 48.0, 50.0, 48.0, 50.0, 49.0, 49.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 73.0, 73.0, 72.0, 73.0, 74.0, 73.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 117.0, 124.0, 117.0, 116.0, 126.0, 118.0, 158.0, 119.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 153.0, 153.0, 153.0, 151.0, 148.0, 150.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 66.0, 61.0, 62.0, 64.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1452.8999999999999, "alertThreshold": 2.0}]} 04:22:18 INFO - Return code: 0 04:22:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:22:18 INFO - # TBPL SUCCESS # 04:22:18 INFO - Running post-action listener: _resource_record_post_action 04:22:18 INFO - [mozharness: 2016-09-25 11:22:18.162151Z] Finished run-tests step (success) 04:22:18 INFO - Running post-run listener: _resource_record_post_run 04:22:18 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 368349184; Read time: 88; Write time: 195976 04:22:18 INFO - TinderboxPrint: CPU usage
12.9% 04:22:18 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 88 04:22:18 INFO - TinderboxPrint: I/O write bytes / time
368,349,184 / 195,976 04:22:18 INFO - TinderboxPrint: CPU idle
8,269.0 (87.0%) 04:22:18 INFO - TinderboxPrint: CPU user
1,185.0 (12.5%) 04:22:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118714368; Read time: 0; Write time: 62752 04:22:18 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248610816; Read time: 12; Write time: 133192 04:22:18 INFO - Running post-run listener: _upload_blobber_files 04:22:18 INFO - Blob upload gear active. 04:22:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:18 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 04:22:18 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'] 04:22:18 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 04:22:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:25 INFO - (blobuploader) - INFO - Done attempting. 04:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:26 INFO - (blobuploader) - INFO - Done attempting. 04:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:22:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:27 INFO - (blobuploader) - INFO - Done attempting. 04:22:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:27 INFO - Return code: 0 04:22:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6755bc41fe2345567db8c5eccbd62625945bd32989f2f54b2e8f0d95d2149a79c296c989d3ccfda472817048683a63d9bef51d77b1671b50c4a53dceaf5ca6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ea259fbdef26a301525dad8102d19efcde1e687cd56e91eafc07914a45b5a9d54dd16d9153184f87379d56d544dfad43b7362c37cd6223e96d1ad2a1381a1a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b92f168eefc548cf94f9a23e3a273e95d2d917d83502643286f005be31c2758d939b3c6eaa08eb57e33608339cf95fed7f46cd1247dceb405a14c118d130b6"} 04:22:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:27 INFO - Contents: 04:22:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6755bc41fe2345567db8c5eccbd62625945bd32989f2f54b2e8f0d95d2149a79c296c989d3ccfda472817048683a63d9bef51d77b1671b50c4a53dceaf5ca6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ea259fbdef26a301525dad8102d19efcde1e687cd56e91eafc07914a45b5a9d54dd16d9153184f87379d56d544dfad43b7362c37cd6223e96d1ad2a1381a1a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b92f168eefc548cf94f9a23e3a273e95d2d917d83502643286f005be31c2758d939b3c6eaa08eb57e33608339cf95fed7f46cd1247dceb405a14c118d130b6"} 04:22:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:27 INFO - Copying logs to upload dir... 04:22:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.565035 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-25 04:22:27.448827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 04:22:27.453100) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 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/6755bc41fe2345567db8c5eccbd62625945bd32989f2f54b2e8f0d95d2149a79c296c989d3ccfda472817048683a63d9bef51d77b1671b50c4a53dceaf5ca6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ea259fbdef26a301525dad8102d19efcde1e687cd56e91eafc07914a45b5a9d54dd16d9153184f87379d56d544dfad43b7362c37cd6223e96d1ad2a1381a1a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b92f168eefc548cf94f9a23e3a273e95d2d917d83502643286f005be31c2758d939b3c6eaa08eb57e33608339cf95fed7f46cd1247dceb405a14c118d130b6"} build_url:https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/FZA8OKqsR0CDErJQJmJeIQ/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/6755bc41fe2345567db8c5eccbd62625945bd32989f2f54b2e8f0d95d2149a79c296c989d3ccfda472817048683a63d9bef51d77b1671b50c4a53dceaf5ca6ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ea259fbdef26a301525dad8102d19efcde1e687cd56e91eafc07914a45b5a9d54dd16d9153184f87379d56d544dfad43b7362c37cd6223e96d1ad2a1381a1a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/77b92f168eefc548cf94f9a23e3a273e95d2d917d83502643286f005be31c2758d939b3c6eaa08eb57e33608339cf95fed7f46cd1247dceb405a14c118d130b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 04:22:27.477667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:22:27.481026) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1474800906.250127-1569075635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 04:22:27.563465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 04:22:27.566818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 04:22:27.567112) ========= ========= Total master_lag: 0.20 =========