builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1481119542.05 results: success (0) buildid: 20161207043003 builduid: 9ead0dfecdc841ecb6b6ccb1c7f4f435 revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.045377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.045812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.046101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.118404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.118681) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 06:05:42-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.6M=0s 2016-12-07 06:05:42 (88.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.260039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.260326) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.310095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:42.310398) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c401d72933641748f3738e90e7bbe539705e2f1c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c401d72933641748f3738e90e7bbe539705e2f1c --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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 06:05:43,018 truncating revision to first 12 chars 2016-12-07 06:05:43,018 Setting DEBUG logging. 2016-12-07 06:05:43,018 attempt 1/10 2016-12-07 06:05:43,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c401d7293364?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 06:05:43,578 unpacking tar archive at: mozilla-central-c401d7293364/testing/mozharness/ program finished with exit code 0 elapsedTime=0.868148 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:43.194251) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:43.194527) ========= script_repo_revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:43.194887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:43.195232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 06:05:43.205550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-07 06:05:43.205823) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:05:43 INFO - MultiFileLogger online at 20161207 06:05:43 in /builds/slave/test 06:05:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:05:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:05:44 INFO - {'append_to_log': False, 06:05:44 INFO - 'base_work_dir': '/builds/slave/test', 06:05:44 INFO - 'blob_upload_branch': 'Firefox', 06:05:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:05:44 INFO - 'branch': 'Firefox', 06:05:44 INFO - 'buildbot_json_path': 'buildprops.json', 06:05:44 INFO - 'config_files': ('talos/linux_config.py',), 06:05:44 INFO - 'default_actions': ('clobber', 06:05:44 INFO - 'read-buildbot-config', 06:05:44 INFO - 'download-and-extract', 06:05:44 INFO - 'populate-webroot', 06:05:44 INFO - 'create-virtualenv', 06:05:44 INFO - 'install', 06:05:44 INFO - 'run-tests'), 06:05:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:05:44 INFO - 'download_minidump_stackwalk': True, 06:05:44 INFO - 'download_symbols': 'ondemand', 06:05:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:05:44 INFO - 'tooltool.py': '/tools/tooltool.py', 06:05:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:05:44 INFO - '/tools/misc-python/virtualenv.py')}, 06:05:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:05:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:05:44 INFO - 'installer_path': 'installer.exe', 06:05:44 INFO - 'log_level': 'info', 06:05:44 INFO - 'log_name': 'talos', 06:05:44 INFO - 'log_to_console': True, 06:05:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:05:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:05:44 INFO - 'opt_config_files': (), 06:05:44 INFO - 'pip_index': False, 06:05:44 INFO - 'sps_profile': False, 06:05:44 INFO - 'sps_profile_interval': 0, 06:05:44 INFO - 'suite': 'dromaeojs', 06:05:44 INFO - 'system_bits': '32', 06:05:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:05:44 INFO - 'title': 'talos-linux64-ix-034', 06:05:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:05:44 INFO - 'use_talos_json': True, 06:05:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:05:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:05:44 INFO - 'work_dir': 'build'} 06:05:44 INFO - [mozharness: 2016-12-07 14:05:44.007613Z] Running clobber step. 06:05:44 INFO - Running pre-action listener: _resource_record_pre_action 06:05:44 INFO - Running main action method: clobber 06:05:44 INFO - rmtree: /builds/slave/test/build 06:05:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:05:44 INFO - Running post-action listener: _resource_record_post_action 06:05:44 INFO - [mozharness: 2016-12-07 14:05:44.470125Z] Finished clobber step (success) 06:05:44 INFO - [mozharness: 2016-12-07 14:05:44.470224Z] Running read-buildbot-config step. 06:05:44 INFO - Running pre-action listener: _resource_record_pre_action 06:05:44 INFO - Running main action method: read_buildbot_config 06:05:44 INFO - Using buildbot properties: 06:05:44 INFO - { 06:05:44 INFO - "project": "", 06:05:44 INFO - "product": "firefox", 06:05:44 INFO - "script_repo_revision": "production", 06:05:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:05:44 INFO - "repository": "", 06:05:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:05:44 INFO - "buildid": "20161207043003", 06:05:44 INFO - "pgo_build": "True", 06:05:44 INFO - "basedir": "/builds/slave/test", 06:05:44 INFO - "buildnumber": 99, 06:05:44 INFO - "slavename": "talos-linux64-ix-034", 06:05:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:05:44 INFO - "platform": "ubuntu64_hw", 06:05:44 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:05:44 INFO - "branch": "mozilla-central", 06:05:44 INFO - "repo_path": "mozilla-central", 06:05:44 INFO - "revision": "c401d72933641748f3738e90e7bbe539705e2f1c", 06:05:44 INFO - "stage_platform": "linux64-pgo", 06:05:44 INFO - "builduid": "9ead0dfecdc841ecb6b6ccb1c7f4f435", 06:05:44 INFO - "slavebuilddir": "test" 06:05:44 INFO - } 06:05:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 06:05:44 INFO - Running post-action listener: _resource_record_post_action 06:05:44 INFO - [mozharness: 2016-12-07 14:05:44.472669Z] Finished read-buildbot-config step (success) 06:05:44 INFO - [mozharness: 2016-12-07 14:05:44.472758Z] Running download-and-extract step. 06:05:44 INFO - Running pre-action listener: _resource_record_pre_action 06:05:44 INFO - Running main action method: download_and_extract 06:05:44 INFO - mkdir: /builds/slave/test/build/tests 06:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:44 INFO - trying https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:05:45 INFO - Downloaded 1361 bytes. 06:05:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 06:05:45 INFO - Using the following test package requirements: 06:05:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:05:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:05:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'jsshell-linux-x86_64.zip'], 06:05:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:05:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 06:05:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:05:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:05:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:05:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 06:05:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:05:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:05:46 INFO - Expected file size: 21781246 06:05:46 INFO - Obtained file size: 21781246 06:05:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:05:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 06:05:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:05:50 INFO - Fetch https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:05:51 INFO - Expected file size: 21781246 06:05:51 INFO - Obtained file size: 21781246 06:05:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 06:05:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:05:56 INFO - Fetch https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:05:57 INFO - Expected file size: 14409734 06:05:57 INFO - Obtained file size: 14409734 06:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:58 INFO - trying https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:05:58 INFO - Downloading https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:06:00 INFO - Downloaded 59837426 bytes. 06:06:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:06:00 INFO - mkdir: /builds/slave/test/properties 06:06:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:06:00 INFO - Writing to file /builds/slave/test/properties/build_url 06:06:00 INFO - Contents: 06:06:00 INFO - build_url:https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 06:06:01 INFO - Running post-action listener: _resource_record_post_action 06:06:01 INFO - Running post-action listener: set_extra_try_arguments 06:06:01 INFO - [mozharness: 2016-12-07 14:06:01.139720Z] Finished download-and-extract step (success) 06:06:01 INFO - [mozharness: 2016-12-07 14:06:01.139946Z] Running populate-webroot step. 06:06:01 INFO - Running pre-action listener: _resource_record_pre_action 06:06:01 INFO - Running main action method: populate_webroot 06:06:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:06:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:06:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:06:01 INFO - '--tppagecycles', 06:06:01 INFO - '7'], 06:06:01 INFO - 'tests': ['tsvgm']}}, 06:06:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:06:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:06:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:06:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:06:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:06:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:06:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['damp', 'tps']}, 06:06:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'tests': ['damp', 'tps']}, 06:06:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['dromaeo_dom']}, 06:06:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:06:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['basic_compositor_video']}, 06:06:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:06:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['a11yr', 06:06:01 INFO - 'ts_paint', 06:06:01 INFO - 'tpaint', 06:06:01 INFO - 'sessionrestore', 06:06:01 INFO - 'sessionrestore_no_auto_restore', 06:06:01 INFO - 'tabpaint']}, 06:06:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['tsvgx', 06:06:01 INFO - 'tsvgr_opacity', 06:06:01 INFO - 'tart', 06:06:01 INFO - 'tscrollx', 06:06:01 INFO - 'cart', 06:06:01 INFO - 'tsvg_static']}, 06:06:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:06:01 INFO - 'tsvgr_opacity', 06:06:01 INFO - 'tart', 06:06:01 INFO - 'tscrollx', 06:06:01 INFO - 'cart', 06:06:01 INFO - 'tsvg_static']}, 06:06:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'talos_options': ['--disable-e10s'], 06:06:01 INFO - 'tests': ['tp5o']}, 06:06:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:06:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'talos_options': ['--disable-e10s', 06:06:01 INFO - '--xperf_path', 06:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:06:01 INFO - 'tests': ['tp5n']}, 06:06:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:06:01 INFO - 'talos_options': ['--xperf_path', 06:06:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:06:01 INFO - 'tests': ['tp5n']}}, 06:06:01 INFO - 'talos.zip': {'path': '', 06:06:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:06:01 INFO - Running post-action listener: _resource_record_post_action 06:06:01 INFO - [mozharness: 2016-12-07 14:06:01.160234Z] Finished populate-webroot step (success) 06:06:01 INFO - [mozharness: 2016-12-07 14:06:01.160322Z] Running create-virtualenv step. 06:06:01 INFO - Running pre-action listener: _resource_record_pre_action 06:06:01 INFO - Running main action method: create_virtualenv 06:06:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:06:01 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 06:06:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:06:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:06:01 INFO - Using real prefix '/usr' 06:06:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:06:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:06:03 INFO - Installing pip.................done. 06:06:03 INFO - Return code: 0 06:06:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:06:03 INFO - Reading from file tmpfile_stdout 06:06:03 INFO - Output received: 06:06:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:06:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:06: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')]} 06:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06: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')]} 06:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:03 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:03 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 06:06:03 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 06:06:03 INFO - Using env: {'DISPLAY': ':0', 06:06:03 INFO - 'HOME': '/home/cltbld', 06:06:03 INFO - 'LANG': 'en_US.UTF-8', 06:06:03 INFO - 'LANGUAGE': 'en_US:en', 06:06:03 INFO - 'LOGNAME': 'cltbld', 06:06:03 INFO - 'MAIL': '/var/mail/cltbld', 06:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:03 INFO - 'MOZ_NO_REMOTE': '1', 06:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:03 INFO - 'NO_EM_RESTART': '1', 06:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:03 INFO - 'PWD': '/builds/slave/test', 06:06:03 INFO - 'SHELL': '/bin/bash', 06:06:03 INFO - 'SHLVL': '1', 06:06:03 INFO - 'TERM': 'linux', 06:06:03 INFO - 'TMOUT': '86400', 06:06:03 INFO - 'USER': 'cltbld', 06:06:03 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:03 INFO - '_': '/tools/buildbot/bin/python'} 06:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:04 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 06:06:04 INFO - Cleaning up... 06:06:04 INFO - Return code: 0 06:06:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:06:04 INFO - Using env: {'DISPLAY': ':0', 06:06:04 INFO - 'HOME': '/home/cltbld', 06:06:04 INFO - 'LANG': 'en_US.UTF-8', 06:06:04 INFO - 'LANGUAGE': 'en_US:en', 06:06:04 INFO - 'LOGNAME': 'cltbld', 06:06:04 INFO - 'MAIL': '/var/mail/cltbld', 06:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:04 INFO - 'MOZ_NO_REMOTE': '1', 06:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:04 INFO - 'NO_EM_RESTART': '1', 06:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:04 INFO - 'PWD': '/builds/slave/test', 06:06:04 INFO - 'SHELL': '/bin/bash', 06:06:04 INFO - 'SHLVL': '1', 06:06:04 INFO - 'TERM': 'linux', 06:06:04 INFO - 'TMOUT': '86400', 06:06:04 INFO - 'USER': 'cltbld', 06:06:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:04 INFO - '_': '/tools/buildbot/bin/python'} 06:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:04 INFO - Downloading/unpacking psutil>=3.1.1 06:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:06:06 INFO - Installing collected packages: psutil 06:06:06 INFO - Running setup.py install for psutil 06:06:06 INFO - building 'psutil._psutil_linux' extension 06:06:06 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 06:06:06 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 06:06:06 INFO - building 'psutil._psutil_posix' extension 06:06:06 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 06:06:06 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 06:06:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:06:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:06:06 INFO - Successfully installed psutil 06:06:06 INFO - Cleaning up... 06:06:07 INFO - Return code: 0 06:06:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:06:07 INFO - Using env: {'DISPLAY': ':0', 06:06:07 INFO - 'HOME': '/home/cltbld', 06:06:07 INFO - 'LANG': 'en_US.UTF-8', 06:06:07 INFO - 'LANGUAGE': 'en_US:en', 06:06:07 INFO - 'LOGNAME': 'cltbld', 06:06:07 INFO - 'MAIL': '/var/mail/cltbld', 06:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:07 INFO - 'MOZ_NO_REMOTE': '1', 06:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:07 INFO - 'NO_EM_RESTART': '1', 06:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:07 INFO - 'PWD': '/builds/slave/test', 06:06:07 INFO - 'SHELL': '/bin/bash', 06:06:07 INFO - 'SHLVL': '1', 06:06:07 INFO - 'TERM': 'linux', 06:06:07 INFO - 'TMOUT': '86400', 06:06:07 INFO - 'USER': 'cltbld', 06:06:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:07 INFO - '_': '/tools/buildbot/bin/python'} 06:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:06:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:06:09 INFO - Installing collected packages: mozsystemmonitor 06:06:09 INFO - Running setup.py install for mozsystemmonitor 06:06:09 INFO - Successfully installed mozsystemmonitor 06:06:09 INFO - Cleaning up... 06:06:09 INFO - Return code: 0 06:06:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:06:09 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')]} 06:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:09 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')]} 06:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:09 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:09 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 06:06:09 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 06:06:09 INFO - Using env: {'DISPLAY': ':0', 06:06:09 INFO - 'HOME': '/home/cltbld', 06:06:09 INFO - 'LANG': 'en_US.UTF-8', 06:06:09 INFO - 'LANGUAGE': 'en_US:en', 06:06:09 INFO - 'LOGNAME': 'cltbld', 06:06:09 INFO - 'MAIL': '/var/mail/cltbld', 06:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:09 INFO - 'MOZ_NO_REMOTE': '1', 06:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:09 INFO - 'NO_EM_RESTART': '1', 06:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:09 INFO - 'PWD': '/builds/slave/test', 06:06:09 INFO - 'SHELL': '/bin/bash', 06:06:09 INFO - 'SHLVL': '1', 06:06:09 INFO - 'TERM': 'linux', 06:06:09 INFO - 'TMOUT': '86400', 06:06:09 INFO - 'USER': 'cltbld', 06:06:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:09 INFO - '_': '/tools/buildbot/bin/python'} 06:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:09 INFO - Downloading/unpacking jsonschema==2.5.1 06:06:09 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 06:06:09 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 06:06:09 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 06:06:09 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 06:06:09 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 06:06:09 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 06:06:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:06:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:06:11 INFO - warning: no files found matching '*.txt' 06:06:11 INFO - no previously-included directories found matching 'build' 06:06:11 INFO - no previously-included directories found matching 'dist' 06:06:11 INFO - no previously-included directories found matching '.git*' 06:06:11 INFO - Installing collected packages: jsonschema, functools32 06:06:11 INFO - Running setup.py install for functools32 06:06:12 INFO - warning: no files found matching '*.txt' 06:06:12 INFO - no previously-included directories found matching 'build' 06:06:12 INFO - no previously-included directories found matching 'dist' 06:06:12 INFO - no previously-included directories found matching '.git*' 06:06:12 INFO - Successfully installed jsonschema functools32 06:06:12 INFO - Cleaning up... 06:06:12 INFO - Return code: 0 06:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:12 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 06:06:12 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 06:06:12 INFO - Using env: {'DISPLAY': ':0', 06:06:12 INFO - 'HOME': '/home/cltbld', 06:06:12 INFO - 'LANG': 'en_US.UTF-8', 06:06:12 INFO - 'LANGUAGE': 'en_US:en', 06:06:12 INFO - 'LOGNAME': 'cltbld', 06:06:12 INFO - 'MAIL': '/var/mail/cltbld', 06:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:12 INFO - 'MOZ_NO_REMOTE': '1', 06:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:12 INFO - 'NO_EM_RESTART': '1', 06:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:12 INFO - 'PWD': '/builds/slave/test', 06:06:12 INFO - 'SHELL': '/bin/bash', 06:06:12 INFO - 'SHLVL': '1', 06:06:12 INFO - 'TERM': 'linux', 06:06:12 INFO - 'TMOUT': '86400', 06:06:12 INFO - 'USER': 'cltbld', 06:06:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:12 INFO - '_': '/tools/buildbot/bin/python'} 06:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:06:12 INFO - Cleaning up... 06:06:12 INFO - Return code: 0 06:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:12 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:12 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 06:06:12 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 06:06:12 INFO - Using env: {'DISPLAY': ':0', 06:06:12 INFO - 'HOME': '/home/cltbld', 06:06:12 INFO - 'LANG': 'en_US.UTF-8', 06:06:12 INFO - 'LANGUAGE': 'en_US:en', 06:06:12 INFO - 'LOGNAME': 'cltbld', 06:06:12 INFO - 'MAIL': '/var/mail/cltbld', 06:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:12 INFO - 'MOZ_NO_REMOTE': '1', 06:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:12 INFO - 'NO_EM_RESTART': '1', 06:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:12 INFO - 'PWD': '/builds/slave/test', 06:06:12 INFO - 'SHELL': '/bin/bash', 06:06:12 INFO - 'SHLVL': '1', 06:06:12 INFO - 'TERM': 'linux', 06:06:12 INFO - 'TMOUT': '86400', 06:06:12 INFO - 'USER': 'cltbld', 06:06:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:12 INFO - '_': '/tools/buildbot/bin/python'} 06:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:12 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 06:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 06:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:06:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06: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 06:06:15 INFO - Downloading docopt-0.6.1.tar.gz 06:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:06:15 INFO - Installing collected packages: blobuploader, requests, docopt 06:06:15 INFO - Running setup.py install for blobuploader 06:06:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:06:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:06:15 INFO - Running setup.py install for requests 06:06:15 INFO - Running setup.py install for docopt 06:06:15 INFO - Successfully installed blobuploader requests docopt 06:06:15 INFO - Cleaning up... 06:06:15 INFO - Return code: 0 06:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:15 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:15 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 06:06:15 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 06:06:15 INFO - Using env: {'DISPLAY': ':0', 06:06:15 INFO - 'HOME': '/home/cltbld', 06:06:15 INFO - 'LANG': 'en_US.UTF-8', 06:06:15 INFO - 'LANGUAGE': 'en_US:en', 06:06:15 INFO - 'LOGNAME': 'cltbld', 06:06:15 INFO - 'MAIL': '/var/mail/cltbld', 06:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:15 INFO - 'MOZ_NO_REMOTE': '1', 06:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:15 INFO - 'NO_EM_RESTART': '1', 06:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:15 INFO - 'PWD': '/builds/slave/test', 06:06:15 INFO - 'SHELL': '/bin/bash', 06:06:15 INFO - 'SHLVL': '1', 06:06:15 INFO - 'TERM': 'linux', 06:06:15 INFO - 'TMOUT': '86400', 06:06:15 INFO - 'USER': 'cltbld', 06:06:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:15 INFO - '_': '/tools/buildbot/bin/python'} 06:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:06:16 INFO - Running setup.py (path:/tmp/pip-v23hLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:06:16 INFO - Running setup.py (path:/tmp/pip-2Stw2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:06:16 INFO - Running setup.py (path:/tmp/pip-IJEEp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:06:16 INFO - Running setup.py (path:/tmp/pip-Eb7SNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:06:16 INFO - Running setup.py (path:/tmp/pip-HEN2o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:06:16 INFO - Running setup.py (path:/tmp/pip-5qu8rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:06:16 INFO - Running setup.py (path:/tmp/pip-foNRpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:06:16 INFO - Running setup.py (path:/tmp/pip-9AduGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:06:16 INFO - Running setup.py (path:/tmp/pip-JjlrND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:06:16 INFO - Running setup.py (path:/tmp/pip-Sej20O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:06:16 INFO - Running setup.py (path:/tmp/pip-nykTlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:06:16 INFO - Running setup.py (path:/tmp/pip-HFWcQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:06:17 INFO - Running setup.py (path:/tmp/pip-vk_7J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:06:17 INFO - Running setup.py (path:/tmp/pip-UU4SOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:17 INFO - Running setup.py (path:/tmp/pip-2GATAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:06:17 INFO - Running setup.py (path:/tmp/pip-ORGWsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:06:17 INFO - Running setup.py (path:/tmp/pip-hgezrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:06:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:06:17 INFO - Running setup.py install for manifestparser 06:06:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:06:17 INFO - Running setup.py install for mozcrash 06:06:17 INFO - Running setup.py install for mozdebug 06:06:17 INFO - Running setup.py install for mozdevice 06:06:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:06:17 INFO - Running setup.py install for mozfile 06:06:17 INFO - Running setup.py install for mozhttpd 06:06:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozinfo 06:06:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozInstall 06:06:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozleak 06:06:18 INFO - Running setup.py install for mozlog 06:06:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for moznetwork 06:06:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozprocess 06:06:18 INFO - Running setup.py install for mozprofile 06:06:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozrunner 06:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:06:18 INFO - Running setup.py install for mozscreenshot 06:06:18 INFO - Running setup.py install for moztest 06:06:19 INFO - Running setup.py install for mozversion 06:06:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:06:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:06:19 INFO - Cleaning up... 06:06:19 INFO - Return code: 0 06:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06:19 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')]} 06:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:19 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')]} 06:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:19 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 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:19 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 06:06:19 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 06:06:19 INFO - Using env: {'DISPLAY': ':0', 06:06:19 INFO - 'HOME': '/home/cltbld', 06:06:19 INFO - 'LANG': 'en_US.UTF-8', 06:06:19 INFO - 'LANGUAGE': 'en_US:en', 06:06:19 INFO - 'LOGNAME': 'cltbld', 06:06:19 INFO - 'MAIL': '/var/mail/cltbld', 06:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:19 INFO - 'MOZ_NO_REMOTE': '1', 06:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:19 INFO - 'NO_EM_RESTART': '1', 06:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:19 INFO - 'PWD': '/builds/slave/test', 06:06:19 INFO - 'SHELL': '/bin/bash', 06:06:19 INFO - 'SHLVL': '1', 06:06:19 INFO - 'TERM': 'linux', 06:06:19 INFO - 'TMOUT': '86400', 06:06:19 INFO - 'USER': 'cltbld', 06:06:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:19 INFO - '_': '/tools/buildbot/bin/python'} 06:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:06:19 INFO - Running setup.py (path:/tmp/pip-6TIzsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:06:19 INFO - Running setup.py (path:/tmp/pip-_94SYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:06:19 INFO - Running setup.py (path:/tmp/pip-xt512L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:06:19 INFO - Running setup.py (path:/tmp/pip-az2Wq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:06:19 INFO - Running setup.py (path:/tmp/pip-Svby42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:06:19 INFO - Running setup.py (path:/tmp/pip-tB4N4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:06:19 INFO - Running setup.py (path:/tmp/pip-JMgSmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:06:19 INFO - Running setup.py (path:/tmp/pip-JVZPDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:06:19 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)) 06:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:06:19 INFO - Running setup.py (path:/tmp/pip-iJpPWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:06:20 INFO - Running setup.py (path:/tmp/pip-ZvPZ9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:06:20 INFO - Running setup.py (path:/tmp/pip-lEG5Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:06:20 INFO - Running setup.py (path:/tmp/pip-eg5sIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:06:20 INFO - Running setup.py (path:/tmp/pip-mu5FgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:06:20 INFO - Running setup.py (path:/tmp/pip-DOXC1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:20 INFO - Running setup.py (path:/tmp/pip-lrZmjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:06:20 INFO - Running setup.py (path:/tmp/pip-qecOyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:06:20 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)) 06:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:06:20 INFO - Running setup.py (path:/tmp/pip-F1h5oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:06:20 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)) 06:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:06:20 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)) 06:06:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:06:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:06:20 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 06:06:20 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 06:06:20 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 06:06:20 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 06:06:20 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 06:06:20 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 06:06:22 INFO - Downloading blessings-1.6.tar.gz 06:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:06:22 INFO - Installing collected packages: blessings 06:06:22 INFO - Running setup.py install for blessings 06:06:22 INFO - Successfully installed blessings 06:06:22 INFO - Cleaning up... 06:06:22 INFO - Return code: 0 06:06:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:23 INFO - Reading from file tmpfile_stdout 06:06:23 INFO - Current package versions: 06:06:23 INFO - argparse == 1.2.1 06:06:23 INFO - blessings == 1.6 06:06:23 INFO - blobuploader == 1.2.4 06:06:23 INFO - docopt == 0.6.1 06:06:23 INFO - functools32 == 3.2.3-2 06:06:23 INFO - jsonschema == 2.5.1 06:06:23 INFO - manifestparser == 1.1 06:06:23 INFO - mozInstall == 1.12 06:06:23 INFO - mozcrash == 1.0 06:06:23 INFO - mozdebug == 0.1 06:06:23 INFO - mozdevice == 0.49 06:06:23 INFO - mozfile == 1.2 06:06:23 INFO - mozhttpd == 0.7 06:06:23 INFO - mozinfo == 0.9 06:06:23 INFO - mozleak == 0.1 06:06:23 INFO - mozlog == 3.4 06:06:23 INFO - moznetwork == 0.27 06:06:23 INFO - mozprocess == 0.23 06:06:23 INFO - mozprofile == 0.28 06:06:23 INFO - mozrunner == 6.13 06:06:23 INFO - mozscreenshot == 0.1 06:06:23 INFO - mozsystemmonitor == 0.3 06:06:23 INFO - moztest == 0.7 06:06:23 INFO - mozversion == 1.4 06:06:23 INFO - psutil == 3.1.1 06:06:23 INFO - requests == 1.2.3 06:06:23 INFO - wsgiref == 0.1.2 06:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:06: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')]} 06:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06: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')]} 06:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:06:23 INFO - Using env: {'DISPLAY': ':0', 06:06:23 INFO - 'HOME': '/home/cltbld', 06:06:23 INFO - 'LANG': 'en_US.UTF-8', 06:06:23 INFO - 'LANGUAGE': 'en_US:en', 06:06:23 INFO - 'LOGNAME': 'cltbld', 06:06:23 INFO - 'MAIL': '/var/mail/cltbld', 06:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:23 INFO - 'MOZ_NO_REMOTE': '1', 06:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:23 INFO - 'NO_EM_RESTART': '1', 06:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:23 INFO - 'PWD': '/builds/slave/test', 06:06:23 INFO - 'SHELL': '/bin/bash', 06:06:23 INFO - 'SHLVL': '1', 06:06:23 INFO - 'TERM': 'linux', 06:06:23 INFO - 'TMOUT': '86400', 06:06:23 INFO - 'USER': 'cltbld', 06:06:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:23 INFO - '_': '/tools/buildbot/bin/python'} 06:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:06:23 INFO - Cleaning up... 06:06:23 INFO - Return code: 0 06:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:06: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')]} 06:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06: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')]} 06:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f335782ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc28a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', '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 06:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:06:23 INFO - Using env: {'DISPLAY': ':0', 06:06:23 INFO - 'HOME': '/home/cltbld', 06:06:23 INFO - 'LANG': 'en_US.UTF-8', 06:06:23 INFO - 'LANGUAGE': 'en_US:en', 06:06:23 INFO - 'LOGNAME': 'cltbld', 06:06:23 INFO - 'MAIL': '/var/mail/cltbld', 06:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:23 INFO - 'MOZ_NO_REMOTE': '1', 06:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:23 INFO - 'NO_EM_RESTART': '1', 06:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:23 INFO - 'PWD': '/builds/slave/test', 06:06:23 INFO - 'SHELL': '/bin/bash', 06:06:23 INFO - 'SHLVL': '1', 06:06:23 INFO - 'TERM': 'linux', 06:06:23 INFO - 'TMOUT': '86400', 06:06:23 INFO - 'USER': 'cltbld', 06:06:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:23 INFO - '_': '/tools/buildbot/bin/python'} 06:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:06:23 INFO - Cleaning up... 06:06:23 INFO - Return code: 0 06:06:23 INFO - Running post-action listener: _resource_record_post_action 06:06:23 INFO - Running post-action listener: _start_resource_monitoring 06:06:23 INFO - Starting resource monitoring. 06:06:23 INFO - [mozharness: 2016-12-07 14:06:23.607474Z] Finished create-virtualenv step (success) 06:06:23 INFO - [mozharness: 2016-12-07 14:06:23.607941Z] Running install step. 06:06:23 INFO - Running pre-action listener: _resource_record_pre_action 06:06:23 INFO - Running main action method: install 06:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:06:23 INFO - Reading from file tmpfile_stdout 06:06:23 INFO - Detecting whether we're running mozinstall >=1.0... 06:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:06:23 INFO - Reading from file tmpfile_stdout 06:06:23 INFO - Output received: 06:06:23 INFO - Usage: mozinstall [options] installer 06:06:23 INFO - Options: 06:06:23 INFO - -h, --help show this help message and exit 06:06:23 INFO - -d DEST, --destination=DEST 06:06:23 INFO - Directory to install application into. [default: 06:06:23 INFO - "/builds/slave/test"] 06:06:23 INFO - --app=APP Application being installed. [default: firefox] 06:06:23 INFO - mkdir: /builds/slave/test/build/application 06:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:06:40 INFO - Reading from file tmpfile_stdout 06:06:40 INFO - Output received: 06:06:40 INFO - /builds/slave/test/build/application/firefox/firefox 06:06:40 INFO - Running post-action listener: _resource_record_post_action 06:06:40 INFO - [mozharness: 2016-12-07 14:06:40.872604Z] Finished install step (success) 06:06:40 INFO - [mozharness: 2016-12-07 14:06:40.872844Z] Running run-tests step. 06:06:40 INFO - Running pre-action listener: _resource_record_pre_action 06:06:40 INFO - Running main action method: run_tests 06:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:06:40 INFO - Python 2.7.3 06:06:40 INFO - Return code: 0 06:06:40 INFO - grabbing minidump binary from tooltool 06:06:40 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')]} 06:06:40 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 0xe56f20>, '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 0xdc3c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:06:40 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 06:06:40 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 06:06:40 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 06:06:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:06:40 INFO - Return code: 0 06:06:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:06:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:06:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:06:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:06:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 06:06:40 INFO - Using env: {'DISPLAY': ':0', 06:06:40 INFO - 'HOME': '/home/cltbld', 06:06:40 INFO - 'LANG': 'en_US.UTF-8', 06:06:40 INFO - 'LANGUAGE': 'en_US:en', 06:06:40 INFO - 'LOGNAME': 'cltbld', 06:06:40 INFO - 'MAIL': '/var/mail/cltbld', 06:06:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:06:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:06:40 INFO - 'MOZ_NO_REMOTE': '1', 06:06:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:06:40 INFO - 'NO_EM_RESTART': '1', 06:06:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:06:40 INFO - 'PWD': '/builds/slave/test', 06:06:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:06:40 INFO - 'SHELL': '/bin/bash', 06:06:40 INFO - 'SHLVL': '1', 06:06:40 INFO - 'TERM': 'linux', 06:06:40 INFO - 'TMOUT': '86400', 06:06:40 INFO - 'USER': 'cltbld', 06:06:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227', 06:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:06:40 INFO - '_': '/tools/buildbot/bin/python'} 06:06:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 06:06:41 INFO - mozversion application_buildid: 20161207043003 06:06:41 INFO - mozversion application_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 06:06:41 INFO - mozversion application_display_name: Nightly 06:06:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:06:41 INFO - mozversion application_name: Firefox 06:06:41 INFO - mozversion application_remotingname: firefox 06:06:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:06:41 INFO - mozversion application_vendor: Mozilla 06:06:41 INFO - mozversion application_version: 53.0a1 06:06:41 INFO - mozversion platform_buildid: 20161207043003 06:06:41 INFO - mozversion platform_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 06:06:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:06:41 INFO - mozversion platform_version: 53.0a1 06:06:41 INFO - using testdate: 1481119601 06:06:41 INFO - actual date: 1481119601 06:06:41 INFO - starting webserver on 'localhost:50179' 06:06:41 INFO - SUITE-START | Running 2 tests 06:06:41 INFO - TEST-START | dromaeo_css 06:06:41 INFO - operating with platform_type : linux_ 06:06:41 INFO - Initialising browser for dromaeo_css test... 06:06:41 INFO - TEST-INFO | started process 2091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN23IjK/profile http://localhost:50179/getInfo.html) 06:06:45 INFO - PROCESS | 2091 | __metrics Screen width/height:1600/1200 06:06:45 INFO - PROCESS | 2091 | colorDepth:24 06:06:45 INFO - PROCESS | 2091 | Browser inner width/height: 1024/697 06:06:45 INFO - PROCESS | 2091 | __metrics 06:06:45 INFO - PROCESS | 2091 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:06:45 INFO - PROCESS | 2091 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:46 INFO - PROCESS | 2091 | console.error: PushService: 06:06:46 INFO - PROCESS | 2091 | stateChangeProcessEnqueue: Error transitioning state 06:06:46 INFO - PROCESS | 2091 | UnknownError 06:06:47 INFO - TEST-INFO | 2091: exit 0 06:06:47 INFO - Browser initialized. 06:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:06:47 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN23IjK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:59 INFO - PROCESS | 2178 | RSS: Main: 172052480 06:06:59 INFO - PROCESS | 2178 | 06:07:50 INFO - PROCESS | 2178 | 1481119670306 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] 06:10:01 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50179/tests/dromaeo/cssquery-ext.html) 06:10:04 INFO - PROCESS | 2178 | RSS: Main: 433831936 06:10:04 INFO - PROCESS | 2178 | 06:13:07 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-ext.html (next: http://localhost:50179/tests/dromaeo/cssquery-jquery.html) 06:13:07 INFO - PROCESS | 2178 | RSS: Main: 282386432 06:13:07 INFO - PROCESS | 2178 | 06:16:10 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50179/tests/dromaeo/cssquery-mootools.html) 06:16:10 INFO - PROCESS | 2178 | RSS: Main: 261005312 06:16:10 INFO - PROCESS | 2178 | 06:19:12 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50179/tests/dromaeo/cssquery-prototype.html) 06:19:13 INFO - PROCESS | 2178 | RSS: Main: 252370944 06:19:13 INFO - PROCESS | 2178 | 06:22:16 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50179/tests/dromaeo/cssquery-yui.html) 06:22:16 INFO - PROCESS | 2178 | RSS: Main: 224669696 06:22:16 INFO - PROCESS | 2178 | 06:25:19 INFO - PROCESS | 2178 | Cycle 1(1): loaded http://localhost:50179/tests/dromaeo/cssquery-yui.html (next: http://localhost:50179/tests/dromaeo/cssquery-dojo.html) 06:25:19 INFO - PROCESS | 2178 | RSS: Main: 314568704 06:25:19 INFO - PROCESS | 2178 | 06:25:19 INFO - PROCESS | 2178 | __start_tp_report 06:25:19 INFO - PROCESS | 2178 | _x_x_mozilla_page_load 06:25:19 INFO - PROCESS | 2178 | _x_x_mozilla_page_load_details 06:25:19 INFO - PROCESS | 2178 | |i|pagename|runs| 06:25:19 INFO - PROCESS | 2178 | |0;dojo.html;3264.934701305974;3283.0971482842215;3300.834958252088;3337.5494308268376;3354.9329013419733;5201.349831271091;5267.683938963665;5320.654157479761;5410.83767486976;5420.024395608789;5323.387810401805;5333.519983201511;5402.729863506828;5410.810621628244;5468.72656367181;4802.135615589193;4817.807287708488;4867.245576935563;4892.5596696297325;4904.779284932169;4872.3422337984275;4935.679180853233;4985.700857948516;4988.925166122511;5017.899642007158;4788.11419887322;4881.682690625134;4885.413750349981;4933.975330123344;4992.425871024842;4822.469528351879;4888.828890988798;4890.266460030988;4890.975545122252;4895.608351331921;4861.343718597979;4873.366462359906;4878.146324393252;4879;4879.682820616648;5277.683338999673;5326.92009619856;5333.546648534841;5334.22653715213;5362.1420572708175;5693.459121383462;5707.486326230659;5711.143328500717;5712.2574065371655;5714.71426428681;5658;5698.943010569883;5708.486236238717;5726.599138060337;5730.19777231188;5339.626226164209;5378.300820893259;5385.569154467633;5414.052540805344;5429.945700542944;5839.065749480063;5842.649441033552;5842.707864606753;5844.970775146182;5845.824625261249;5468.453154684579;5513.3108361454815;5550.250716153268;5622.522085622686;5640.971795140998;5659.179418984307;5679.176519404663;5733.655980641175;5764;5780.554861284679;5705.058665320259;5708.971455142698;5712.714364281769;5712.857178570569;5713.771449142071;5508.476694713996;5560.471755183251;5711.7144142792695;5716.885662286731;5765.365809760923;4410.669199809963;4436.44544431946;4449.777511124431;4455.68810183284;4505.459344878635;3996.760194388346;3999.2201520703184;4003.5011985637316;4011.8194681239415;4039.030632648143;5489.204065410493;5494.642848214853;5501.257330260363;5503.11950087984;5528.530074943595;5554.833354999357;5581.5813813963305;5596.860078497989;5644.350899646511;5651.321841379061;5346.599005074635;5350.0904846176245;5355.464453554613;5356.544693701079;5399.082156033483;4930.975345123252;4934.161192597196;4978.27814966835;4982.875428114254;5007.524285192901;5690.402507736628;5792.797252096157;5797.333306669619;5889.087191485327;5895.469407753237;5687.402822703557;5690.886182276414;5694.032014557618;5712.11462223356;5791.160281759206;5909.054551271776;5929.080992446177;5929.673867937305;5938.435848594377;5971.373005834324;5607.074832652566;5655.858603534944;5660.207570940154;5664.603477756517;5665;5519.9448005521035;5547.472990065938;5557.388687244319;5725.65646061221;5789.305283366023;5523.1991361253195;5526.143447765603;5528.170774383874;5528.226048353154;5532.253145825262;5503.036968530571;5517.558595312285;5521.585881058856;5523.061079616556;5524.861878453071;5401.675899446046;5426.077566813572;5450.863728406822;5452.781888724565;5456.399796022513;5541.944580554304;5542.7782888685615;5545.833624991256;5547.750351234285;5555.250041244381;5440.537554307928;5467.097928841856;5479.232907392889;5483.479069488392;5488.588355873246 06:25:19 INFO - PROCESS | 2178 | |1;ext.html;575.7380391921677;595.4462350014487;629.6977450823605;635.9682015899203;642.1491523731057;31334.686653133464;41130.58869411309;42530.787346063225;42741.7862910685;46816.06367872641;43013.78493107538;43367.566324336745;43382.78308608461;43389.78305108478;43440.78279608605;7799.649015794274;8403.705870294541;8547.95726021369;8554.828903421927;8558.315334773235;7755.8061048473955;9811.116999470047;10105.797884042315;10108.292419530635;10418.218633602472;10139.188864890828;10200;10204.877463479012;10207.183425325957;10213;10132.949335253314;10152.289339746258;10189.286749927509;10189.388636681822;10192.541335639915;9762.170215531689;9826.115649591571;9826.459544725038;9826.705198844045;9833.26250531206;40764.79617601893;41045.1790964179;41057.38413923793;41086.1782764343;41095.589044109474;3287.1654649125844;3336.4494858348344;3420.555327807369;3489.773164744309;3625.9456108158133;28742.856285718437;30482.237944051354;30904.690953090405;31174.22064448384;31992.360152797046;4138.234426631083;4219.6202341789385;4256.6705868925765;4423.800928958204;4430.379746835446;306233;308893;309626.4518677415;311162;311570;58814.705926470095;59005.40994590085;59585.70207149023;59615.40384596185;59692.40307596955;61951.38048619546;62025.68987155126;62065.68967155135;62096.37903620996;62103;16565.42021029282;16861.662766744597;16883.577910552336;17005.149742512825;17038.914805425895;11924.880751192377;12162.452689628988;12792.552260671018;13071.673208169872;13154.60536183916;18190.727139092924;18719.157637906326;18734.812651873308;18781.624367512846;18789.62420751577;6532.510061745388;6944;7014.754483593049;7110.57336559808;7113.53762005468;860.8149247911729;973.1096047116808;989.9653512127041;1034.0538407357185;1104.1553211792984;30998.845005774827;31458.685413145577;31831.363372732416;31839;32310.83844580809;1090.3839330778085;1096.7970925378831;1097.7145942054963;1136.4488223211736;1156.1329003247565;16072.276747546388;16411;16483.83516164847;16553.503394898173;16781;527189.5529402295;531958;532100;533728;534326;56932;57617.71191144017;57734.711326443095;57739.422605773405;57777;1311.1215485624655;1335.138835451148;1359.558143603313;1361.394179590073;1363.7817949128091;29663.25841853971;30512.237194070327;31050.223744406572;33894.3221135571;33970.49044264387;54909.450905490434;55686.72156639191;55699.72150139223;55740.721296394884;55775.163372550254;431734;432537;433027;433377;433842;35198.29603407866;36232.456513151796;37612.435813462274;40412;42312.36531451969;45245.321320179566;45431.54568454406;45540.54459455496;46101;46562.76718616385;38603.42094868523;39128.608713913636;39240.170961533426;39656.801715991234;40506.594934050285;39149.412758808074;39632;39763.80118099391;39810.20379592334;41105;38952;39709;39822;40344.18451169763;40427.59572404238;31790.841045794623;34690.82654586711;34954.825225873705;35612.37039184993;36089.63910360863;26662.46675066449;26930;27301;27340.918668352453;27469.31326716848 06:25:19 INFO - PROCESS | 2178 | |2;jquery.html;362.9100185305514;368.9243705040467;401.39589917174646;403.97374170678904;414.2770864840853;14948.252587370614;15752.212389380542;17746.73379899301;19296;19304.806951930477;14666.853331466682;15542.53372398827;16326.183690815471;17878.195481203344;18057.187426565804;5193.714345710975;5637.267155269809;5668.149777533383;5671.120976248688;5676.602637815355;5548.362680264531;5612.550995920337;5661.094224924013;5684;5704.34400043994;5550.27846379972;5645.350784659755;5646.887062258752;5647.830565083054;5648.265725455685;5398.953629473447;5552.972235138819;5563.527100196488;5570.303712035975;5631.8592035199035;4993.800247990076;5018.222175562793;5023.095842748304;5024.321716568253;5030.37120359955;21250.5749885003;21441.463963400885;21655;21678.34964951054;21717.45706357338;2263.8302127340517;2494.750524947509;2744.519709050928;2914.2422970027733;2972.093511478998;9792.510374481319;10229.18166546682;10243.07812296897;13859.514916977858;14031.298435078308;1829.5517598188396;1889.7826749923797;1893.479293194369;1907.1131923655566;1908.7583601622616;80633.66732465502;81622;82033.58983205046;82423.5878820608;83478;10755.139588832875;10824;10942.234043617029;11014.669559913216;11066.944665276622;15355.692886142215;15404.383824647113;15409.691806163813;15413.922930385277;15425.84574154244;7099.183593886769;7428.85142297151;7591.620418979029;7645.808854778564;8016.799580010546;7579.242075792376;7610.277023682741;7711.228877112244;7825.491343062683;7847.843043139105;4478.328250762346;4684.1334353144775;4706.9174089958815;4722.386089808303;4812.663113582015;1779.9915054635203;1823.699089650193;1830.8352248297717;1931.8454523638075;1957.4421289932302;878.1964502480159;907.1065000974036;916.4959272400154;927.7436198941629;995.3878364805593;17579.82420175782;17827.554311142325;18136.546586335448;18175.45473635793;18418.35535756242;910.544727636182;936.1387523478417;952.7713348796239;952.8570714392896;972.3533849989819;10000.449975251286;10371.377717336984;10494.790104197873;10500.842487362695;10523;424372;427827;428996;429165;434200;89355.10644893468;89583.55208223917;91113.54443227741;91402.54298728464;91413.54293228491;952.6808519146025;985;1009.8384258518602;1017.3285631483334;1020.4285600063988;15739.685206296039;16408.26162822652;16703.83296167023;16795.74806377881;16974.6050789845;38667.613323866404;39386.40920386254;39943.60056399515;40293.59706402898;40427.39358909678;52570.73714631402;54153;56394;56564;57710.711446442496;8067.273945344947;8073.233042860918;8194.262516373556;8321.791955201168;8424.28393586552;11929.347554453596;11933.940330298641;12077.51689932428;12228.266304021787;12361.381930903599;10385.688429347132;10654.231598184537;10846.403447810446;10919.344839309666;11298.378589177673;10629.574817007233;10801.891981080404;10901.781964360827;11327.15046371542;11546.59586914454;10945.45272736376;11090.833637495283;11139.665810025712;11319.264247823865;11637.359945202756;8274.627641756257;8321.251087402163;8381.37139714536;8436.620352084294;8871.911280887109;8969.955150224469;10738.838917416402;10768.300060496043;11045.834312485158;11354.829677554679 06:25:19 INFO - PROCESS | 2178 | |3;mootools.html;1417.4684493315008;1441.6251774538616;1568.7176308264516;1684.663067386523;1716.2963185094113;6911;7097.964510177455;7594.6202689865495;8020.679172833087;8025.398095142873;7629.122650895135;7867.763967080997;7875.881861772078;8036.357091432686;8038.477498962563;2275.7724227577232;2310.4685922237895;2312.063614236237;2316.0156933303365;2318.9536209275802;1988.7812340642517;2054.578811343671;2232.3749350181974;2278.840481166319;2280.749117597063;2195.089038049208;2281.7718228177214;2284.9314520564326;2287.7712228777073;2295.8048565871836;2247.2696373678455;2261.5250797332496;2264.094362255095;2264.445210923318;2264.784845439681;2165.577712346093;2197.7252843394576;2210.9778902210933;2215.2468160825397;2216.490207252341;7893.05283365994;7959.7214097506885;7990.840183196362;8007.439479236456;8016.238457346601;4822.300766388889;4939.185034469308;4951.851444456672;4988.102141614508;5008.12357837377;3163.5254711793414;3305.5702758641464;3344.4147274227157;3364.49532570114;3376.7129793967542;1053.673361258005;1055.2430203710812;1089.3463921647028;1131.8189089745683;1155.653304008794;10563.524641391155;10630.309029913109;10640.467976601216;10649.307794993378;10650.840237396445;4242.44848169736;4350.73895566267;4463.642908567307;4475.462944446687;4545.931811022837;9169.22061624756;9256.16694497485;9258.305627077996;9261.073892610684;9264.861027084598;5082.364704411949;5082.491750824888;5089.491050894881;5090.949090509122;5148.871278218;4605.746683932416;4682.648801339913;4715.363425937523;4742.5257474252985;4748.762561871893;3689.8339574719203;3747.7376583638884;3772.2266935278203;3778.4521244419407;3840.1551658635058;1158.8956993870424;1198.2810313811644;1212.1030437476204;1212.3449645276817;1213.696575856036;867.2584939876441;905.1536813079791;923.8244733500613;932.1051790281406;945.3854994253653;5495.038368285614;5520.475554822286;5648.124540696199;5691.487766100988;5733.31200255972;931.9068093190763;977.2865807960087;988.7676396046924;990.3562684255147;996.4320337407753;3713.5436286852714;3862.3240932837202;3924.843006279774;3986.940195897064;4018.3972404139026;9288.767780805534;9486.288528360263;9607.327487075838;9616.711498655051;9618.374805637612;9537.713868583953;9544.18446558267;9566;9572.186364159124;9588.568514416867;7421.183669796426;7520.962395187989;7532.887006694904;7538.773836784905;7547.05661792276;5356.330458692663;5357.571394288369;5372.838814835562;5461.290032295935;5555.472230138131;8599.484030958163;8647.437916535406;8798.692045778367;8887.555622218992;9069.274458043472;8941.061188575106;8991.685291015045;9047.276217902421;9062.728118156467;9084.18242358191;7032.261612530815;7114.110736157981;7169.749058782918;7171.569705817667;7172.748953786592;7183.748568800067;7390.187079421152;7397.593132377771;7488.32605065525;7626.694932202649;5670.631408958405;6773.864522709419;6867.656617169221;6898.275681053417;6993.790186294419;6496.382843629847;6527.608343499405;6553.180852393451;6606.471482281502;6606.636634985122;5959.940400595939;6008.579399441997;6038.758449661965;6038.909416358671;6067.939320606914;4695.647826413101;4778.617710583215;4833.3958255218095;4883.340748998839;4929.852104436873;4919.877003074952;4961.950380496149;5031.22016087507;5098.796048158032;5122.334096567422 06:25:19 INFO - PROCESS | 2178 | |4;prototype.html;308.0803800655044;315.3787039532121;321.2867434295865;331.9137024373663;336.2551947436428;5075.883305672755;5199.766010529525;5270.65740726853;5282.418933917271;5298.178782288742;5072.72100034498;5141.177411614133;5216.22648299578;5224.1902505111675;5229.555487783534;4134.4831896013;4138.255114079465;4142.855000074998;4152.480939882522;4157.542670306264;3869.361555343365;3872.4965754451882;4139.606737359961;4158.710799652117;4163.271427500191;4055.675545956331;4061.3095773718537;4091.243120022805;4097.242010228102;4097.889586862768;4079.714419990602;4089.3865920111925;4090.979545102285;4091.7340372875965;4092.877213683594;3637.527121474218;3654.2691461707764;3655.4334078217917;3661.176235347052;3683.097641077953;5015.247712843103;5059.1905295152965;5060.671056381323;5080.542751152377;5084.79660813567;4646.744429056401;4648.279516674921;4666.9766651166865;4667.06316878495;4672.6261899047995;5483.616146869721;5486.451354864522;5492.780288788444;5514.6139770216105;5534.584906132056;3772.924716455824;3918.471006414126;3948.940765888514;3950.4666869972475;3964.484616999772;5681.744321505501;5698.17376480408;5705.972924873521;5719.313682358102;5731.742071606746;4019.1559772447526;4021.2761702893176;4025.3156963316305;4037.5962403759977;4060.4112403701297;3952.3083460394314;4023.295923213426;4068.247374235776;4084.1627466369323;4099.405586190045;4648.256278995412;4653.115907977473;4654.325122857167;4654.976725116353;4671.32265821454;5426.538744206708;5519.227308176858;5544.3346798384455;5548.167774833807;5554.166874968787;1316.2826259688493;1354.478525767567;1363.9727205455836;1366.8769810717083;1379.165604809076;908.2869947091501;941.30343545777;952.9523523823781;956.4739393333639;959.4818797849083;5091.643584949018;5130.281760553526;5147.768350424165;5151.5106064923775;5170.689758614495;5408.648437851606;5411.591841630437;5416.0772925610845;5428.430014848384;5445.611369100854;4966.9817687374;5078.289039534468;5109.718965456936;5144.279800827887;5148.845534633967;2859.8274707370297;2883.7548808351107;2884.0676746579843;2886.8123571968176;2902.998465529389;5571;5591.9720401397735;5595.356533998643;5596.524295434933;5597.80407685729;5233.398159211663;5477.097138516592;5491.423400542965;5530.308711411074;5540.861478463071;5624.493795558419;5632.60571759981;5643.463870932337;5649.971750141223;5655.717214139194;5249.186376111708;5407.756650950795;5460.361891432475;5471.890562188813;5472.261244731911;5282.204050622807;5332.706701131475;5339.839804805862;5385.488378604026;5422.267993820941;5576.247206627054;5596.356419011703;5600.69196194197;5602.355729091207;5692.715364231854;3858.884233473;3868.471953578377;3871.1676989447406;3893.279743247508;3917.7845218512116;5639.434057503908;5644.435556444323;5653.915191272216;5671.829845104653;5681;5529.336479622471;5541.667499950016;5543.473370029841;5562.276904002454;5568.916466252928;5326.440723723953;5491.890162196813;5493.890122197614;5554.444555544414;5558.333000040021;5447.12845944647;5447.727613619224;5448.128299472065;5461.781528738806;5475.302656176598;5458.399576046552;5496.790706044664;5547.195656629847;5562.610617256753;5571.247881535941;5166.759977605423;5311.787528498817;5321.148616221541;5336.893262134813;5342.198670199501 06:25:19 INFO - PROCESS | 2178 | |5;yui.html;727.9745208917689;741.2328240271316;769.9268569485901;804.1837534902073;810.1736229046377;15637;16589.170541472922;16595.66808663826;16613.750793738072;16624.750628740578;15011.249437528108;15179.848201517982;15182.392704291842;15183.848161518381;15195.240237988084;661.6890061671007;666.9466442684574;772.2162005564329;775.2634996753079;776.1539921485579;774.044055591347;775.8293175501381;775.9185285545021;779.8713212319989;783.6551917156462;840.2437805974641;841.4614646626134;841.6801615386145;843.1399972028527;843.2537204573965;840.2647683277132;840.8864803251544;841.4656692999959;841.6380956188837;841.8021764885247;516.2101983964541;520.2534363188836;594.2749845188906;601.0683440666949;612.6201754911939;13456.058075934689;13501.59495215145;13507;13521.053526253167;13536.59390218295;13606.455741770318;13615.795763063563;13950.162990220619;13984.16095034291;14121;11544.935869743356;11619.883801161965;11779.352135632536;11884.524619015228;12073.758524829542;4183.184279065584;4190.979045104786;4229.6827737919775;4304.311310190355;4332.826686932519;77044.61477692632;77773.61113194455;78018;78743.21256787416;79183.60408197979;11200.383978881076;11220.607278745369;11340.94329528347;11349.148813838996;11378.715532111597;21899.78100219009;21954.45113872166;21977.23079692203;22012.889935550218;22323.44191395228;7687.692492300357;7772.261635144652;7990.161033091558;8029.879551806727;8363.247307742211;4346.587074227943;4373.081652852873;4376.431063961664;4474.955250447454;4475.753833539122;3381.6618338165986;3396.677315655009;3414.3683418567643;3433.6738009889023;3453.153977275533;575.7495489462098;591.9498769653408;593.658646278383;594.2126682146173;611.0528680545137;625.9374062593795;675.2538445018282;686.3561769561871;691.9965400173068;705.6365971524668;8648.870266946002;8900.510471924106;8961.462312261156;9218.354715169873;9260.21288190498;638.1799387786765;642.855357544558;663.9269680335159;667.4393509452084;682.952193346471;4478.126765280739;4651.790669419885;4670.95329046712;4685.273782563708;4722.834700785456;85149;86293.56853215693;86328;86401.56799215963;87463.56268218618;73528.63235683895;73878;73965.26034739584;74312.62843685855;74415;66249.33750662528;66350.33649663441;67774.66112669405;69139;69202;8672.913270867211;8750.343724220582;9016.618767962014;9056;9105.135012173832;43659.56340436555;45568.316475252235;46654.066918660756;47146.76426617845;47294.52705473039;46273;63512.68243658752;63918.68040659767;63928;65579;11122.666320010412;11655.4556818858;11669.59156429521;11734.88265117372;11783.410829458322;12573.874261257637;13452.327383630975;13555.118917270345;14733;14979.40082396692;13835.239061851293;13876.444942202199;14169.716605668034;14528.782068268772;15437.372217528648;13161.934190328988;13245.80131298012;14023.929880350533;14207.431702731776;14630.561083167522;13835.861641383457;14057.156570605797;14225.217613031382;14264.780645354045;15084.773728394302;11188.1608879336;11541.480633371686;11985.520579176735;12240.632781016584;12297.200681956003;11204.607838725606;11309.79657707582;11843.467043983213;11921.880781192423;11961 06:25:19 INFO - PROCESS | 2178 | __end_tp_report 06:25:19 INFO - PROCESS | 2178 | __start_cc_report 06:25:19 INFO - PROCESS | 2178 | _x_x_mozilla_cycle_collect,2673 06:25:19 INFO - PROCESS | 2178 | __end_cc_report 06:25:19 INFO - PROCESS | 2178 | __startTimestamp1481120719988__endTimestamp 06:25:19 INFO - PROCESS | 2178 | 06:25:19 INFO - PROCESS | 2178 | ------- Summary: start ------- 06:25:20 INFO - PROCESS | 2178 | Number of tests: 6 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#0] dojo.html Cycles:165 Average:5310.48 Median:5494.64 stddev:550.91 (10.0%) stddev-sans-first:528.71 06:25:20 INFO - PROCESS | 2178 | Values: 3264.9 3283.1 3300.8 3337.5 3354.9 5201.3 5267.7 5320.7 5410.8 5420.0 5323.4 5333.5 5402.7 5410.8 5468.7 4802.1 4817.8 4867.2 4892.6 4904.8 4872.3 4935.7 4985.7 4988.9 5017.9 4788.1 4881.7 4885.4 4934.0 4992.4 4822.5 4888.8 4890.3 4891.0 4895.6 4861.3 4873.4 4878.1 4879.0 4879.7 5277.7 5326.9 5333.5 5334.2 5362.1 5693.5 5707.5 5711.1 5712.3 5714.7 5658.0 5698.9 5708.5 5726.6 5730.2 5339.6 5378.3 5385.6 5414.1 5429.9 5839.1 5842.6 5842.7 5845.0 5845.8 5468.5 5513.3 5550.3 5622.5 5641.0 5659.2 5679.2 5733.7 5764.0 5780.6 5705.1 5709.0 5712.7 5712.9 5713.8 5508.5 5560.5 5711.7 5716.9 5765.4 4410.7 4436.4 4449.8 4455.7 4505.5 3996.8 3999.2 4003.5 4011.8 4039.0 5489.2 5494.6 5501.3 5503.1 5528.5 5554.8 5581.6 5596.9 5644.4 5651.3 5346.6 5350.1 5355.5 5356.5 5399.1 4931.0 4934.2 4978.3 4982.9 5007.5 5690.4 5792.8 5797.3 5889.1 5895.5 5687.4 5690.9 5694.0 5712.1 5791.2 5909.1 5929.1 5929.7 5938.4 5971.4 5607.1 5655.9 5660.2 5664.6 5665.0 5519.9 5547.5 5557.4 5725.7 5789.3 5523.2 5526.1 5528.2 5528.2 5532.3 5503.0 5517.6 5521.6 5523.1 5524.9 5401.7 5426.1 5450.9 5452.8 5456.4 5541.9 5542.8 5545.8 5547.8 5555.3 5440.5 5467.1 5479.2 5483.5 5488.6 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#1] ext.html Cycles:180 Average:59021.49 Median:39682.90 stddev:115129.80 (290.1%) stddev-sans-first:115369.14 06:25:20 INFO - PROCESS | 2178 | Values: 575.7 595.4 629.7 636.0 642.1 31334.7 41130.6 42530.8 42741.8 46816.1 43013.8 43367.6 43382.8 43389.8 43440.8 7799.6 8403.7 8548.0 8554.8 8558.3 7755.8 9811.1 10105.8 10108.3 10418.2 10139.2 10200.0 10204.9 10207.2 10213.0 10132.9 10152.3 10189.3 10189.4 10192.5 9762.2 9826.1 9826.5 9826.7 9833.3 40764.8 41045.2 41057.4 41086.2 41095.6 3287.2 3336.4 3420.6 3489.8 3625.9 28742.9 30482.2 30904.7 31174.2 31992.4 4138.2 4219.6 4256.7 4423.8 4430.4 306233.0 308893.0 309626.5 311162.0 311570.0 58814.7 59005.4 59585.7 59615.4 59692.4 61951.4 62025.7 62065.7 62096.4 62103.0 16565.4 16861.7 16883.6 17005.1 17038.9 11924.9 12162.5 12792.6 13071.7 13154.6 18190.7 18719.2 18734.8 18781.6 18789.6 6532.5 6944.0 7014.8 7110.6 7113.5 860.8 973.1 990.0 1034.1 1104.2 30998.8 31458.7 31831.4 31839.0 32310.8 1090.4 1096.8 1097.7 1136.4 1156.1 16072.3 16411.0 16483.8 16553.5 16781.0 527189.6 531958.0 532100.0 533728.0 534326.0 56932.0 57617.7 57734.7 57739.4 57777.0 1311.1 1335.1 1359.6 1361.4 1363.8 29663.3 30512.2 31050.2 33894.3 33970.5 54909.5 55686.7 55699.7 55740.7 55775.2 431734.0 432537.0 433027.0 433377.0 433842.0 35198.3 36232.5 37612.4 40412.0 42312.4 45245.3 45431.5 45540.5 46101.0 46562.8 38603.4 39128.6 39240.2 39656.8 40506.6 39149.4 39632.0 39763.8 39810.2 41105.0 38952.0 39709.0 39822.0 40344.2 40427.6 31790.8 34690.8 34954.8 35612.4 36089.6 26662.5 26930.0 27301.0 27340.9 27469.3 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#2] jquery.html Cycles:180 Average:26793.45 Median:20172.50 stddev:71113.26 (352.5%) stddev-sans-first:71285.06 06:25:20 INFO - PROCESS | 2178 | Values: 362.9 368.9 401.4 404.0 414.3 14948.3 15752.2 17746.7 19296.0 19304.8 14666.9 15542.5 16326.2 17878.2 18057.2 5193.7 5637.3 5668.1 5671.1 5676.6 5548.4 5612.6 5661.1 5684.0 5704.3 5550.3 5645.4 5646.9 5647.8 5648.3 5399.0 5553.0 5563.5 5570.3 5631.9 4993.8 5018.2 5023.1 5024.3 5030.4 21250.6 21441.5 21655.0 21678.3 21717.5 2263.8 2494.8 2744.5 2914.2 2972.1 9792.5 10229.2 10243.1 13859.5 14031.3 1829.6 1889.8 1893.5 1907.1 1908.8 80633.7 81622.0 82033.6 82423.6 83478.0 10755.1 10824.0 10942.2 11014.7 11066.9 15355.7 15404.4 15409.7 15413.9 15425.8 7099.2 7428.9 7591.6 7645.8 8016.8 7579.2 7610.3 7711.2 7825.5 7847.8 4478.3 4684.1 4706.9 4722.4 4812.7 1780.0 1823.7 1830.8 1931.8 1957.4 878.2 907.1 916.5 927.7 995.4 17579.8 17827.6 18136.5 18175.5 18418.4 910.5 936.1 952.8 952.9 972.4 10000.4 10371.4 10494.8 10500.8 10523.0 424372.0 427827.0 428996.0 429165.0 434200.0 89355.1 89583.6 91113.5 91402.5 91413.5 952.7 985.0 1009.8 1017.3 1020.4 15739.7 16408.3 16703.8 16795.7 16974.6 38667.6 39386.4 39943.6 40293.6 40427.4 52570.7 54153.0 56394.0 56564.0 57710.7 8067.3 8073.2 8194.3 8321.8 8424.3 11929.3 11933.9 12077.5 12228.3 12361.4 10385.7 10654.2 10846.4 10919.3 11298.4 10629.6 10801.9 10901.8 11327.2 11546.6 10945.5 11090.8 11139.7 11319.3 11637.4 8274.6 8321.3 8381.4 8436.6 8871.9 8970.0 10738.8 10768.3 11045.8 11354.8 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#3] mootools.html Cycles:180 Average:5262.13 Median:5356.95 stddev:2822.79 (52.7%) stddev-sans-first:2815.92 06:25:20 INFO - PROCESS | 2178 | Values: 1417.5 1441.6 1568.7 1684.7 1716.3 6911.0 7098.0 7594.6 8020.7 8025.4 7629.1 7867.8 7875.9 8036.4 8038.5 2275.8 2310.5 2312.1 2316.0 2319.0 1988.8 2054.6 2232.4 2278.8 2280.7 2195.1 2281.8 2284.9 2287.8 2295.8 2247.3 2261.5 2264.1 2264.4 2264.8 2165.6 2197.7 2211.0 2215.2 2216.5 7893.1 7959.7 7990.8 8007.4 8016.2 4822.3 4939.2 4951.9 4988.1 5008.1 3163.5 3305.6 3344.4 3364.5 3376.7 1053.7 1055.2 1089.3 1131.8 1155.7 10563.5 10630.3 10640.5 10649.3 10650.8 4242.4 4350.7 4463.6 4475.5 4545.9 9169.2 9256.2 9258.3 9261.1 9264.9 5082.4 5082.5 5089.5 5090.9 5148.9 4605.7 4682.6 4715.4 4742.5 4748.8 3689.8 3747.7 3772.2 3778.5 3840.2 1158.9 1198.3 1212.1 1212.3 1213.7 867.3 905.2 923.8 932.1 945.4 5495.0 5520.5 5648.1 5691.5 5733.3 931.9 977.3 988.8 990.4 996.4 3713.5 3862.3 3924.8 3986.9 4018.4 9288.8 9486.3 9607.3 9616.7 9618.4 9537.7 9544.2 9566.0 9572.2 9588.6 7421.2 7521.0 7532.9 7538.8 7547.1 5356.3 5357.6 5372.8 5461.3 5555.5 8599.5 8647.4 8798.7 8887.6 9069.3 8941.1 8991.7 9047.3 9062.7 9084.2 7032.3 7114.1 7169.7 7171.6 7172.7 7183.7 7390.2 7397.6 7488.3 7626.7 5670.6 6773.9 6867.7 6898.3 6993.8 6496.4 6527.6 6553.2 6606.5 6606.6 5959.9 6008.6 6038.8 6038.9 6067.9 4695.6 4778.6 4833.4 4883.3 4929.9 4919.9 4962.0 5031.2 5098.8 5122.3 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#4] prototype.html Cycles:180 Average:4571.79 Median:5220.21 stddev:1334.03 (25.6%) stddev-sans-first:1298.82 06:25:20 INFO - PROCESS | 2178 | Values: 308.1 315.4 321.3 331.9 336.3 5075.9 5199.8 5270.7 5282.4 5298.2 5072.7 5141.2 5216.2 5224.2 5229.6 4134.5 4138.3 4142.9 4152.5 4157.5 3869.4 3872.5 4139.6 4158.7 4163.3 4055.7 4061.3 4091.2 4097.2 4097.9 4079.7 4089.4 4091.0 4091.7 4092.9 3637.5 3654.3 3655.4 3661.2 3683.1 5015.2 5059.2 5060.7 5080.5 5084.8 4646.7 4648.3 4667.0 4667.1 4672.6 5483.6 5486.5 5492.8 5514.6 5534.6 3772.9 3918.5 3948.9 3950.5 3964.5 5681.7 5698.2 5706.0 5719.3 5731.7 4019.2 4021.3 4025.3 4037.6 4060.4 3952.3 4023.3 4068.2 4084.2 4099.4 4648.3 4653.1 4654.3 4655.0 4671.3 5426.5 5519.2 5544.3 5548.2 5554.2 1316.3 1354.5 1364.0 1366.9 1379.2 908.3 941.3 953.0 956.5 959.5 5091.6 5130.3 5147.8 5151.5 5170.7 5408.6 5411.6 5416.1 5428.4 5445.6 4967.0 5078.3 5109.7 5144.3 5148.8 2859.8 2883.8 2884.1 2886.8 2903.0 5571.0 5592.0 5595.4 5596.5 5597.8 5233.4 5477.1 5491.4 5530.3 5540.9 5624.5 5632.6 5643.5 5650.0 5655.7 5249.2 5407.8 5460.4 5471.9 5472.3 5282.2 5332.7 5339.8 5385.5 5422.3 5576.2 5596.4 5600.7 5602.4 5692.7 3858.9 3868.5 3871.2 3893.3 3917.8 5639.4 5644.4 5653.9 5671.8 5681.0 5529.3 5541.7 5543.5 5562.3 5568.9 5326.4 5491.9 5493.9 5554.4 5558.3 5447.1 5447.7 5448.1 5461.8 5475.3 5458.4 5496.8 5547.2 5562.6 5571.2 5166.8 5311.8 5321.1 5336.9 5342.2 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - PROCESS | 2178 | [#5] yui.html Cycles:180 Average:18264.29 Median:25662.51 stddev:23992.41 (93.5%) stddev-sans-first:24023.58 06:25:20 INFO - PROCESS | 2178 | Values: 728.0 741.2 769.9 804.2 810.2 15637.0 16589.2 16595.7 16613.8 16624.8 15011.2 15179.8 15182.4 15183.8 15195.2 661.7 666.9 772.2 775.3 776.2 774.0 775.8 775.9 779.9 783.7 840.2 841.5 841.7 843.1 843.3 840.3 840.9 841.5 841.6 841.8 516.2 520.3 594.3 601.1 612.6 13456.1 13501.6 13507.0 13521.1 13536.6 13606.5 13615.8 13950.2 13984.2 14121.0 11544.9 11619.9 11779.4 11884.5 12073.8 4183.2 4191.0 4229.7 4304.3 4332.8 77044.6 77773.6 78018.0 78743.2 79183.6 11200.4 11220.6 11340.9 11349.1 11378.7 21899.8 21954.5 21977.2 22012.9 22323.4 7687.7 7772.3 7990.2 8029.9 8363.2 4346.6 4373.1 4376.4 4475.0 4475.8 3381.7 3396.7 3414.4 3433.7 3453.2 575.7 591.9 593.7 594.2 611.1 625.9 675.3 686.4 692.0 705.6 8648.9 8900.5 8961.5 9218.4 9260.2 638.2 642.9 663.9 667.4 683.0 4478.1 4651.8 4671.0 4685.3 4722.8 85149.0 86293.6 86328.0 86401.6 87463.6 73528.6 73878.0 73965.3 74312.6 74415.0 66249.3 66350.3 67774.7 69139.0 69202.0 8672.9 8750.3 9016.6 9056.0 9105.1 43659.6 45568.3 46654.1 47146.8 47294.5 46273.0 63512.7 63918.7 63928.0 65579.0 11122.7 11655.5 11669.6 11734.9 11783.4 12573.9 13452.3 13555.1 14733.0 14979.4 13835.2 13876.4 14169.7 14528.8 15437.4 13161.9 13245.8 14023.9 14207.4 14630.6 13835.9 14057.2 14225.2 14264.8 15084.8 11188.2 11541.5 11985.5 12240.6 12297.2 11204.6 11309.8 11843.5 11921.9 11961.0 06:25:20 INFO - PROCESS | 2178 | -------- Summary: end -------- 06:25:20 INFO - PROCESS | 2178 | 06:25:20 INFO - TEST-INFO | 2178: exit 0 06:25:20 INFO - TEST-OK | dromaeo_css | took 1119812ms 06:25:20 INFO - TEST-START | kraken 06:25:20 INFO - operating with platform_type : linux_ 06:25:20 INFO - Initialising browser for kraken test... 06:25:20 INFO - TEST-INFO | started process 2580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2tz5W/profile http://localhost:50179/getInfo.html) 06:25:24 INFO - PROCESS | 2580 | __metrics Screen width/height:1600/1200 06:25:24 INFO - PROCESS | 2580 | colorDepth:24 06:25:24 INFO - PROCESS | 2580 | Browser inner width/height: 1024/697 06:25:24 INFO - PROCESS | 2580 | __metrics 06:25:25 INFO - PROCESS | 2580 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:25:25 INFO - PROCESS | 2580 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:25:26 INFO - PROCESS | 2580 | console.error: PushService: 06:25:26 INFO - PROCESS | 2580 | stateChangeProcessEnqueue: Error transitioning state 06:25:26 INFO - PROCESS | 2580 | UnknownError 06:25:26 INFO - TEST-INFO | 2580: exit 0 06:25:26 INFO - Browser initialized. 06:25:26 INFO - Running cycle 1/1 for kraken test... 06:25:26 INFO - TEST-INFO | started process 2666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2tz5W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:38 INFO - PROCESS | 2666 | RSS: Main: 172040192 06:25:38 INFO - PROCESS | 2666 | 06:25:41 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50179/tests/kraken/driver.html?testName=audio-beat-detection) 06:25:42 INFO - PROCESS | 2666 | RSS: Main: 234782720 06:25:42 INFO - PROCESS | 2666 | 06:25:45 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50179/tests/kraken/driver.html?testName=audio-dft) 06:25:45 INFO - PROCESS | 2666 | RSS: Main: 217276416 06:25:45 INFO - PROCESS | 2666 | 06:25:48 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50179/tests/kraken/driver.html?testName=audio-fft) 06:25:49 INFO - PROCESS | 2666 | RSS: Main: 298586112 06:25:49 INFO - PROCESS | 2666 | 06:25:51 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50179/tests/kraken/driver.html?testName=audio-oscillator) 06:25:51 INFO - PROCESS | 2666 | RSS: Main: 210305024 06:25:51 INFO - PROCESS | 2666 | 06:25:54 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50179/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:25:54 INFO - PROCESS | 2666 | RSS: Main: 213475328 06:25:54 INFO - PROCESS | 2666 | 06:25:57 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50179/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:58 INFO - PROCESS | 2666 | RSS: Main: 253333504 06:25:58 INFO - PROCESS | 2666 | 06:26:01 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50179/tests/kraken/driver.html?testName=imaging-desaturate) 06:26:02 INFO - PROCESS | 2666 | RSS: Main: 252981248 06:26:02 INFO - PROCESS | 2666 | 06:26:04 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50179/tests/kraken/driver.html?testName=json-parse-financial) 06:26:05 INFO - PROCESS | 2666 | RSS: Main: 251539456 06:26:05 INFO - PROCESS | 2666 | 06:26:06 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50179/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:26:07 INFO - PROCESS | 2666 | RSS: Main: 213864448 06:26:07 INFO - PROCESS | 2666 | 06:26:09 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:26:10 INFO - PROCESS | 2666 | RSS: Main: 220475392 06:26:10 INFO - PROCESS | 2666 | 06:26:12 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:26:12 INFO - PROCESS | 2666 | RSS: Main: 229949440 06:26:12 INFO - PROCESS | 2666 | 06:26:15 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:26:16 INFO - PROCESS | 2666 | RSS: Main: 239132672 06:26:16 INFO - PROCESS | 2666 | 06:26:18 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:26:19 INFO - PROCESS | 2666 | RSS: Main: 235364352 06:26:19 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | Cycle 1(1): loaded http://localhost:50179/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50179/tests/kraken/driver.html?testName=ai-astar) 06:26:21 INFO - PROCESS | 2666 | RSS: Main: 286621696 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | __start_tp_report 06:26:21 INFO - PROCESS | 2666 | _x_x_mozilla_page_load 06:26:21 INFO - PROCESS | 2666 | _x_x_mozilla_page_load_details 06:26:21 INFO - PROCESS | 2666 | |i|pagename|runs| 06:26:21 INFO - PROCESS | 2666 | |0;ai-astar;109;111;110;110;111;110;110;112;110;110 06:26:21 INFO - PROCESS | 2666 | |1;audio-beat-detection;153;122;122;159;128;123;122;123;146;122 06:26:21 INFO - PROCESS | 2666 | |2;audio-dft;162;161;161;161;161;161;162;160;161;160 06:26:21 INFO - PROCESS | 2666 | |3;audio-fft;75;75;74;122;76;76;76;76;92;75 06:26:21 INFO - PROCESS | 2666 | |4;audio-oscillator;84;84;106;83;83;83;98;83;83;100 06:26:21 INFO - PROCESS | 2666 | |5;imaging-gaussian-blur;118;117;117;117;117;118;117;117;117;116 06:26:21 INFO - PROCESS | 2666 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;147 06:26:21 INFO - PROCESS | 2666 | |7;imaging-desaturate;95;96;95;96;95;96;95;95;96;95 06:26:21 INFO - PROCESS | 2666 | |8;json-parse-financial;54;53;51;52;52;54;54;52;53;52 06:26:21 INFO - PROCESS | 2666 | |9;json-stringify-tinderbox;63;63;62;62;62;62;63;62;62;63 06:26:21 INFO - PROCESS | 2666 | |10;stanford-crypto-aes;81;81;82;81;82;82;81;81;81;81 06:26:21 INFO - PROCESS | 2666 | |11;stanford-crypto-ccm;141;136;141;139;139;137;132;138;181;130 06:26:21 INFO - PROCESS | 2666 | |12;stanford-crypto-pbkdf2;167;165;162;168;164;162;164;172;168;165 06:26:21 INFO - PROCESS | 2666 | |13;stanford-crypto-sha256-iterative;65;69;66;66;64;71;63;64;64;62 06:26:21 INFO - PROCESS | 2666 | __end_tp_report 06:26:21 INFO - PROCESS | 2666 | __start_cc_report 06:26:21 INFO - PROCESS | 2666 | _x_x_mozilla_cycle_collect,1699 06:26:21 INFO - PROCESS | 2666 | __end_cc_report 06:26:21 INFO - PROCESS | 2666 | __startTimestamp1481120781395__endTimestamp 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | ------- Summary: start ------- 06:26:21 INFO - PROCESS | 2666 | Number of tests: 14 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 06:26:21 INFO - PROCESS | 2666 | Values: 109.0 111.0 110.0 110.0 111.0 110.0 110.0 112.0 110.0 110.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:125.50 stddev:14.70 (11.7%) stddev-sans-first:13.48 06:26:21 INFO - PROCESS | 2666 | Values: 153.0 122.0 122.0 159.0 128.0 123.0 122.0 123.0 146.0 122.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 06:26:21 INFO - PROCESS | 2666 | Values: 162.0 161.0 161.0 161.0 161.0 161.0 162.0 160.0 161.0 160.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:15.11 (19.9%) stddev-sans-first:15.83 06:26:21 INFO - PROCESS | 2666 | Values: 75.0 75.0 74.0 122.0 76.0 76.0 76.0 76.0 92.0 75.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.00 stddev:8.94 (10.8%) stddev-sans-first:9.32 06:26:21 INFO - PROCESS | 2666 | Values: 84.0 84.0 106.0 83.0 83.0 83.0 98.0 83.0 83.0 100.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 06:26:21 INFO - PROCESS | 2666 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 06:26:21 INFO - PROCESS | 2666 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:26:21 INFO - PROCESS | 2666 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.01 06:26:21 INFO - PROCESS | 2666 | Values: 54.0 53.0 51.0 52.0 52.0 54.0 54.0 52.0 53.0 52.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:26:21 INFO - PROCESS | 2666 | Values: 63.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 06:26:21 INFO - PROCESS | 2666 | Values: 81.0 81.0 82.0 81.0 82.0 82.0 81.0 81.0 81.0 81.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:139.00 stddev:14.37 (10.3%) stddev-sans-first:15.24 06:26:21 INFO - PROCESS | 2666 | Values: 141.0 136.0 141.0 139.0 139.0 137.0 132.0 138.0 181.0 130.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:3.09 (1.9%) stddev-sans-first:3.24 06:26:21 INFO - PROCESS | 2666 | Values: 167.0 165.0 162.0 168.0 164.0 162.0 164.0 172.0 168.0 165.0 06:26:21 INFO - PROCESS | 2666 | 06:26:21 INFO - PROCESS | 2666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:2.76 (4.2%) stddev-sans-first:2.92 06:26:21 INFO - PROCESS | 2666 | Values: 65.0 69.0 66.0 66.0 64.0 71.0 63.0 64.0 64.0 62.0 06:26:21 INFO - PROCESS | 2666 | -------- Summary: end -------- 06:26:21 INFO - PROCESS | 2666 | 06:26:22 INFO - TEST-INFO | 2666: exit 0 06:26:22 INFO - TEST-OK | kraken | took 61703ms 06:26:22 INFO - SUITE-END | took 1181s 06:26:23 INFO - Completed test suite (00:19:41) 06:26:23 INFO - javascript benchmark 06:26:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.934701305974, 3283.0971482842215, 3300.834958252088, 3337.5494308268376, 3354.9329013419733, 5201.349831271091, 5267.683938963665, 5320.654157479761, 5410.83767486976, 5420.024395608789, 5323.387810401805, 5333.519983201511, 5402.729863506828, 5410.810621628244, 5468.72656367181, 4802.135615589193, 4817.807287708488, 4867.245576935563, 4892.5596696297325, 4904.779284932169, 4872.3422337984275, 4935.679180853233, 4985.700857948516, 4988.925166122511, 5017.899642007158, 4788.11419887322, 4881.682690625134, 4885.413750349981, 4933.975330123344, 4992.425871024842, 4822.469528351879, 4888.828890988798, 4890.266460030988, 4890.975545122252, 4895.608351331921, 4861.343718597979, 4873.366462359906, 4878.146324393252, 4879.0, 4879.682820616648, 5277.683338999673, 5326.92009619856, 5333.546648534841, 5334.22653715213, 5362.1420572708175, 5693.459121383462, 5707.486326230659, 5711.143328500717, 5712.2574065371655, 5714.71426428681, 5658.0, 5698.943010569883, 5708.486236238717, 5726.599138060337, 5730.19777231188, 5339.626226164209, 5378.300820893259, 5385.569154467633, 5414.052540805344, 5429.945700542944, 5839.065749480063, 5842.649441033552, 5842.707864606753, 5844.970775146182, 5845.824625261249, 5468.453154684579, 5513.3108361454815, 5550.250716153268, 5622.522085622686, 5640.971795140998, 5659.179418984307, 5679.176519404663, 5733.655980641175, 5764.0, 5780.554861284679, 5705.058665320259, 5708.971455142698, 5712.714364281769, 5712.857178570569, 5713.771449142071, 5508.476694713996, 5560.471755183251, 5711.7144142792695, 5716.885662286731, 5765.365809760923, 4410.669199809963, 4436.44544431946, 4449.777511124431, 4455.68810183284, 4505.459344878635, 3996.760194388346, 3999.2201520703184, 4003.5011985637316, 4011.8194681239415, 4039.030632648143, 5489.204065410493, 5494.642848214853, 5501.257330260363, 5503.11950087984, 5528.530074943595, 5554.833354999357, 5581.5813813963305, 5596.860078497989, 5644.350899646511, 5651.321841379061, 5346.599005074635, 5350.0904846176245, 5355.464453554613, 5356.544693701079, 5399.082156033483, 4930.975345123252, 4934.161192597196, 4978.27814966835, 4982.875428114254, 5007.524285192901, 5690.402507736628, 5792.797252096157, 5797.333306669619, 5889.087191485327, 5895.469407753237, 5687.402822703557, 5690.886182276414, 5694.032014557618, 5712.11462223356, 5791.160281759206, 5909.054551271776, 5929.080992446177, 5929.673867937305, 5938.435848594377, 5971.373005834324, 5607.074832652566, 5655.858603534944, 5660.207570940154, 5664.603477756517, 5665.0, 5519.9448005521035, 5547.472990065938, 5557.388687244319, 5725.65646061221, 5789.305283366023, 5523.1991361253195, 5526.143447765603, 5528.170774383874, 5528.226048353154, 5532.253145825262, 5503.036968530571, 5517.558595312285, 5521.585881058856, 5523.061079616556, 5524.861878453071, 5401.675899446046, 5426.077566813572, 5450.863728406822, 5452.781888724565, 5456.399796022513, 5541.944580554304, 5542.7782888685615, 5545.833624991256, 5547.750351234285, 5555.250041244381, 5440.537554307928, 5467.097928841856, 5479.232907392889, 5483.479069488392, 5488.588355873246], "value": 5277.293003803591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7380391921677, 595.4462350014487, 629.6977450823605, 635.9682015899203, 642.1491523731057, 31334.686653133464, 41130.58869411309, 42530.787346063225, 42741.7862910685, 46816.06367872641, 43013.78493107538, 43367.566324336745, 43382.78308608461, 43389.78305108478, 43440.78279608605, 7799.649015794274, 8403.705870294541, 8547.95726021369, 8554.828903421927, 8558.315334773235, 7755.8061048473955, 9811.116999470047, 10105.797884042315, 10108.292419530635, 10418.218633602472, 10139.188864890828, 10200.0, 10204.877463479012, 10207.183425325957, 10213.0, 10132.949335253314, 10152.289339746258, 10189.286749927509, 10189.388636681822, 10192.541335639915, 9762.170215531689, 9826.115649591571, 9826.459544725038, 9826.705198844045, 9833.26250531206, 40764.79617601893, 41045.1790964179, 41057.38413923793, 41086.1782764343, 41095.589044109474, 3287.1654649125844, 3336.4494858348344, 3420.555327807369, 3489.773164744309, 3625.9456108158133, 28742.856285718437, 30482.237944051354, 30904.690953090405, 31174.22064448384, 31992.360152797046, 4138.234426631083, 4219.6202341789385, 4256.6705868925765, 4423.800928958204, 4430.379746835446, 306233.0, 308893.0, 309626.4518677415, 311162.0, 311570.0, 58814.705926470095, 59005.40994590085, 59585.70207149023, 59615.40384596185, 59692.40307596955, 61951.38048619546, 62025.68987155126, 62065.68967155135, 62096.37903620996, 62103.0, 16565.42021029282, 16861.662766744597, 16883.577910552336, 17005.149742512825, 17038.914805425895, 11924.880751192377, 12162.452689628988, 12792.552260671018, 13071.673208169872, 13154.60536183916, 18190.727139092924, 18719.157637906326, 18734.812651873308, 18781.624367512846, 18789.62420751577, 6532.510061745388, 6944.0, 7014.754483593049, 7110.57336559808, 7113.53762005468, 860.8149247911729, 973.1096047116808, 989.9653512127041, 1034.0538407357185, 1104.1553211792984, 30998.845005774827, 31458.685413145577, 31831.363372732416, 31839.0, 32310.83844580809, 1090.3839330778085, 1096.7970925378831, 1097.7145942054963, 1136.4488223211736, 1156.1329003247565, 16072.276747546388, 16411.0, 16483.83516164847, 16553.503394898173, 16781.0, 527189.5529402295, 531958.0, 532100.0, 533728.0, 534326.0, 56932.0, 57617.71191144017, 57734.711326443095, 57739.422605773405, 57777.0, 1311.1215485624655, 1335.138835451148, 1359.558143603313, 1361.394179590073, 1363.7817949128091, 29663.25841853971, 30512.237194070327, 31050.223744406572, 33894.3221135571, 33970.49044264387, 54909.450905490434, 55686.72156639191, 55699.72150139223, 55740.721296394884, 55775.163372550254, 431734.0, 432537.0, 433027.0, 433377.0, 433842.0, 35198.29603407866, 36232.456513151796, 37612.435813462274, 40412.0, 42312.36531451969, 45245.321320179566, 45431.54568454406, 45540.54459455496, 46101.0, 46562.76718616385, 38603.42094868523, 39128.608713913636, 39240.170961533426, 39656.801715991234, 40506.594934050285, 39149.412758808074, 39632.0, 39763.80118099391, 39810.20379592334, 41105.0, 38952.0, 39709.0, 39822.0, 40344.18451169763, 40427.59572404238, 31790.841045794623, 34690.82654586711, 34954.825225873705, 35612.37039184993, 36089.63910360863, 26662.46675066449, 26930.0, 27301.0, 27340.918668352453, 27469.31326716848], "value": 20202.043854504886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.9100185305514, 368.9243705040467, 401.39589917174646, 403.97374170678904, 414.2770864840853, 14948.252587370614, 15752.212389380542, 17746.73379899301, 19296.0, 19304.806951930477, 14666.853331466682, 15542.53372398827, 16326.183690815471, 17878.195481203344, 18057.187426565804, 5193.714345710975, 5637.267155269809, 5668.149777533383, 5671.120976248688, 5676.602637815355, 5548.362680264531, 5612.550995920337, 5661.094224924013, 5684.0, 5704.34400043994, 5550.27846379972, 5645.350784659755, 5646.887062258752, 5647.830565083054, 5648.265725455685, 5398.953629473447, 5552.972235138819, 5563.527100196488, 5570.303712035975, 5631.8592035199035, 4993.800247990076, 5018.222175562793, 5023.095842748304, 5024.321716568253, 5030.37120359955, 21250.5749885003, 21441.463963400885, 21655.0, 21678.34964951054, 21717.45706357338, 2263.8302127340517, 2494.750524947509, 2744.519709050928, 2914.2422970027733, 2972.093511478998, 9792.510374481319, 10229.18166546682, 10243.07812296897, 13859.514916977858, 14031.298435078308, 1829.5517598188396, 1889.7826749923797, 1893.479293194369, 1907.1131923655566, 1908.7583601622616, 80633.66732465502, 81622.0, 82033.58983205046, 82423.5878820608, 83478.0, 10755.139588832875, 10824.0, 10942.234043617029, 11014.669559913216, 11066.944665276622, 15355.692886142215, 15404.383824647113, 15409.691806163813, 15413.922930385277, 15425.84574154244, 7099.183593886769, 7428.85142297151, 7591.620418979029, 7645.808854778564, 8016.799580010546, 7579.242075792376, 7610.277023682741, 7711.228877112244, 7825.491343062683, 7847.843043139105, 4478.328250762346, 4684.1334353144775, 4706.9174089958815, 4722.386089808303, 4812.663113582015, 1779.9915054635203, 1823.699089650193, 1830.8352248297717, 1931.8454523638075, 1957.4421289932302, 878.1964502480159, 907.1065000974036, 916.4959272400154, 927.7436198941629, 995.3878364805593, 17579.82420175782, 17827.554311142325, 18136.546586335448, 18175.45473635793, 18418.35535756242, 910.544727636182, 936.1387523478417, 952.7713348796239, 952.8570714392896, 972.3533849989819, 10000.449975251286, 10371.377717336984, 10494.790104197873, 10500.842487362695, 10523.0, 424372.0, 427827.0, 428996.0, 429165.0, 434200.0, 89355.10644893468, 89583.55208223917, 91113.54443227741, 91402.54298728464, 91413.54293228491, 952.6808519146025, 985.0, 1009.8384258518602, 1017.3285631483334, 1020.4285600063988, 15739.685206296039, 16408.26162822652, 16703.83296167023, 16795.74806377881, 16974.6050789845, 38667.613323866404, 39386.40920386254, 39943.60056399515, 40293.59706402898, 40427.39358909678, 52570.73714631402, 54153.0, 56394.0, 56564.0, 57710.711446442496, 8067.273945344947, 8073.233042860918, 8194.262516373556, 8321.791955201168, 8424.28393586552, 11929.347554453596, 11933.940330298641, 12077.51689932428, 12228.266304021787, 12361.381930903599, 10385.688429347132, 10654.231598184537, 10846.403447810446, 10919.344839309666, 11298.378589177673, 10629.574817007233, 10801.891981080404, 10901.781964360827, 11327.15046371542, 11546.59586914454, 10945.45272736376, 11090.833637495283, 11139.665810025712, 11319.264247823865, 11637.359945202756, 8274.627641756257, 8321.251087402163, 8381.37139714536, 8436.620352084294, 8871.911280887109, 8969.955150224469, 10738.838917416402, 10768.300060496043, 11045.834312485158, 11354.829677554679], "value": 8874.181633720882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.4684493315008, 1441.6251774538616, 1568.7176308264516, 1684.663067386523, 1716.2963185094113, 6911.0, 7097.964510177455, 7594.6202689865495, 8020.679172833087, 8025.398095142873, 7629.122650895135, 7867.763967080997, 7875.881861772078, 8036.357091432686, 8038.477498962563, 2275.7724227577232, 2310.4685922237895, 2312.063614236237, 2316.0156933303365, 2318.9536209275802, 1988.7812340642517, 2054.578811343671, 2232.3749350181974, 2278.840481166319, 2280.749117597063, 2195.089038049208, 2281.7718228177214, 2284.9314520564326, 2287.7712228777073, 2295.8048565871836, 2247.2696373678455, 2261.5250797332496, 2264.094362255095, 2264.445210923318, 2264.784845439681, 2165.577712346093, 2197.7252843394576, 2210.9778902210933, 2215.2468160825397, 2216.490207252341, 7893.05283365994, 7959.7214097506885, 7990.840183196362, 8007.439479236456, 8016.238457346601, 4822.300766388889, 4939.185034469308, 4951.851444456672, 4988.102141614508, 5008.12357837377, 3163.5254711793414, 3305.5702758641464, 3344.4147274227157, 3364.49532570114, 3376.7129793967542, 1053.673361258005, 1055.2430203710812, 1089.3463921647028, 1131.8189089745683, 1155.653304008794, 10563.524641391155, 10630.309029913109, 10640.467976601216, 10649.307794993378, 10650.840237396445, 4242.44848169736, 4350.73895566267, 4463.642908567307, 4475.462944446687, 4545.931811022837, 9169.22061624756, 9256.16694497485, 9258.305627077996, 9261.073892610684, 9264.861027084598, 5082.364704411949, 5082.491750824888, 5089.491050894881, 5090.949090509122, 5148.871278218, 4605.746683932416, 4682.648801339913, 4715.363425937523, 4742.5257474252985, 4748.762561871893, 3689.8339574719203, 3747.7376583638884, 3772.2266935278203, 3778.4521244419407, 3840.1551658635058, 1158.8956993870424, 1198.2810313811644, 1212.1030437476204, 1212.3449645276817, 1213.696575856036, 867.2584939876441, 905.1536813079791, 923.8244733500613, 932.1051790281406, 945.3854994253653, 5495.038368285614, 5520.475554822286, 5648.124540696199, 5691.487766100988, 5733.31200255972, 931.9068093190763, 977.2865807960087, 988.7676396046924, 990.3562684255147, 996.4320337407753, 3713.5436286852714, 3862.3240932837202, 3924.843006279774, 3986.940195897064, 4018.3972404139026, 9288.767780805534, 9486.288528360263, 9607.327487075838, 9616.711498655051, 9618.374805637612, 9537.713868583953, 9544.18446558267, 9566.0, 9572.186364159124, 9588.568514416867, 7421.183669796426, 7520.962395187989, 7532.887006694904, 7538.773836784905, 7547.05661792276, 5356.330458692663, 5357.571394288369, 5372.838814835562, 5461.290032295935, 5555.472230138131, 8599.484030958163, 8647.437916535406, 8798.692045778367, 8887.555622218992, 9069.274458043472, 8941.061188575106, 8991.685291015045, 9047.276217902421, 9062.728118156467, 9084.18242358191, 7032.261612530815, 7114.110736157981, 7169.749058782918, 7171.569705817667, 7172.748953786592, 7183.748568800067, 7390.187079421152, 7397.593132377771, 7488.32605065525, 7626.694932202649, 5670.631408958405, 6773.864522709419, 6867.656617169221, 6898.275681053417, 6993.790186294419, 6496.382843629847, 6527.608343499405, 6553.180852393451, 6606.471482281502, 6606.636634985122, 5959.940400595939, 6008.579399441997, 6038.758449661965, 6038.909416358671, 6067.939320606914, 4695.647826413101, 4778.617710583215, 4833.3958255218095, 4883.340748998839, 4929.852104436873, 4919.877003074952, 4961.950380496149, 5031.22016087507, 5098.796048158032, 5122.334096567422], "value": 4308.685482835894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.0803800655044, 315.3787039532121, 321.2867434295865, 331.9137024373663, 336.2551947436428, 5075.883305672755, 5199.766010529525, 5270.65740726853, 5282.418933917271, 5298.178782288742, 5072.72100034498, 5141.177411614133, 5216.22648299578, 5224.1902505111675, 5229.555487783534, 4134.4831896013, 4138.255114079465, 4142.855000074998, 4152.480939882522, 4157.542670306264, 3869.361555343365, 3872.4965754451882, 4139.606737359961, 4158.710799652117, 4163.271427500191, 4055.675545956331, 4061.3095773718537, 4091.243120022805, 4097.242010228102, 4097.889586862768, 4079.714419990602, 4089.3865920111925, 4090.979545102285, 4091.7340372875965, 4092.877213683594, 3637.527121474218, 3654.2691461707764, 3655.4334078217917, 3661.176235347052, 3683.097641077953, 5015.247712843103, 5059.1905295152965, 5060.671056381323, 5080.542751152377, 5084.79660813567, 4646.744429056401, 4648.279516674921, 4666.9766651166865, 4667.06316878495, 4672.6261899047995, 5483.616146869721, 5486.451354864522, 5492.780288788444, 5514.6139770216105, 5534.584906132056, 3772.924716455824, 3918.471006414126, 3948.940765888514, 3950.4666869972475, 3964.484616999772, 5681.744321505501, 5698.17376480408, 5705.972924873521, 5719.313682358102, 5731.742071606746, 4019.1559772447526, 4021.2761702893176, 4025.3156963316305, 4037.5962403759977, 4060.4112403701297, 3952.3083460394314, 4023.295923213426, 4068.247374235776, 4084.1627466369323, 4099.405586190045, 4648.256278995412, 4653.115907977473, 4654.325122857167, 4654.976725116353, 4671.32265821454, 5426.538744206708, 5519.227308176858, 5544.3346798384455, 5548.167774833807, 5554.166874968787, 1316.2826259688493, 1354.478525767567, 1363.9727205455836, 1366.8769810717083, 1379.165604809076, 908.2869947091501, 941.30343545777, 952.9523523823781, 956.4739393333639, 959.4818797849083, 5091.643584949018, 5130.281760553526, 5147.768350424165, 5151.5106064923775, 5170.689758614495, 5408.648437851606, 5411.591841630437, 5416.0772925610845, 5428.430014848384, 5445.611369100854, 4966.9817687374, 5078.289039534468, 5109.718965456936, 5144.279800827887, 5148.845534633967, 2859.8274707370297, 2883.7548808351107, 2884.0676746579843, 2886.8123571968176, 2902.998465529389, 5571.0, 5591.9720401397735, 5595.356533998643, 5596.524295434933, 5597.80407685729, 5233.398159211663, 5477.097138516592, 5491.423400542965, 5530.308711411074, 5540.861478463071, 5624.493795558419, 5632.60571759981, 5643.463870932337, 5649.971750141223, 5655.717214139194, 5249.186376111708, 5407.756650950795, 5460.361891432475, 5471.890562188813, 5472.261244731911, 5282.204050622807, 5332.706701131475, 5339.839804805862, 5385.488378604026, 5422.267993820941, 5576.247206627054, 5596.356419011703, 5600.69196194197, 5602.355729091207, 5692.715364231854, 3858.884233473, 3868.471953578377, 3871.1676989447406, 3893.279743247508, 3917.7845218512116, 5639.434057503908, 5644.435556444323, 5653.915191272216, 5671.829845104653, 5681.0, 5529.336479622471, 5541.667499950016, 5543.473370029841, 5562.276904002454, 5568.916466252928, 5326.440723723953, 5491.890162196813, 5493.890122197614, 5554.444555544414, 5558.333000040021, 5447.12845944647, 5447.727613619224, 5448.128299472065, 5461.781528738806, 5475.302656176598, 5458.399576046552, 5496.790706044664, 5547.195656629847, 5562.610617256753, 5571.247881535941, 5166.759977605423, 5311.787528498817, 5321.148616221541, 5336.893262134813, 5342.198670199501], "value": 4144.776555477663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.9745208917689, 741.2328240271316, 769.9268569485901, 804.1837534902073, 810.1736229046377, 15637.0, 16589.170541472922, 16595.66808663826, 16613.750793738072, 16624.750628740578, 15011.249437528108, 15179.848201517982, 15182.392704291842, 15183.848161518381, 15195.240237988084, 661.6890061671007, 666.9466442684574, 772.2162005564329, 775.2634996753079, 776.1539921485579, 774.044055591347, 775.8293175501381, 775.9185285545021, 779.8713212319989, 783.6551917156462, 840.2437805974641, 841.4614646626134, 841.6801615386145, 843.1399972028527, 843.2537204573965, 840.2647683277132, 840.8864803251544, 841.4656692999959, 841.6380956188837, 841.8021764885247, 516.2101983964541, 520.2534363188836, 594.2749845188906, 601.0683440666949, 612.6201754911939, 13456.058075934689, 13501.59495215145, 13507.0, 13521.053526253167, 13536.59390218295, 13606.455741770318, 13615.795763063563, 13950.162990220619, 13984.16095034291, 14121.0, 11544.935869743356, 11619.883801161965, 11779.352135632536, 11884.524619015228, 12073.758524829542, 4183.184279065584, 4190.979045104786, 4229.6827737919775, 4304.311310190355, 4332.826686932519, 77044.61477692632, 77773.61113194455, 78018.0, 78743.21256787416, 79183.60408197979, 11200.383978881076, 11220.607278745369, 11340.94329528347, 11349.148813838996, 11378.715532111597, 21899.78100219009, 21954.45113872166, 21977.23079692203, 22012.889935550218, 22323.44191395228, 7687.692492300357, 7772.261635144652, 7990.161033091558, 8029.879551806727, 8363.247307742211, 4346.587074227943, 4373.081652852873, 4376.431063961664, 4474.955250447454, 4475.753833539122, 3381.6618338165986, 3396.677315655009, 3414.3683418567643, 3433.6738009889023, 3453.153977275533, 575.7495489462098, 591.9498769653408, 593.658646278383, 594.2126682146173, 611.0528680545137, 625.9374062593795, 675.2538445018282, 686.3561769561871, 691.9965400173068, 705.6365971524668, 8648.870266946002, 8900.510471924106, 8961.462312261156, 9218.354715169873, 9260.21288190498, 638.1799387786765, 642.855357544558, 663.9269680335159, 667.4393509452084, 682.952193346471, 4478.126765280739, 4651.790669419885, 4670.95329046712, 4685.273782563708, 4722.834700785456, 85149.0, 86293.56853215693, 86328.0, 86401.56799215963, 87463.56268218618, 73528.63235683895, 73878.0, 73965.26034739584, 74312.62843685855, 74415.0, 66249.33750662528, 66350.33649663441, 67774.66112669405, 69139.0, 69202.0, 8672.913270867211, 8750.343724220582, 9016.618767962014, 9056.0, 9105.135012173832, 43659.56340436555, 45568.316475252235, 46654.066918660756, 47146.76426617845, 47294.52705473039, 46273.0, 63512.68243658752, 63918.68040659767, 63928.0, 65579.0, 11122.666320010412, 11655.4556818858, 11669.59156429521, 11734.88265117372, 11783.410829458322, 12573.874261257637, 13452.327383630975, 13555.118917270345, 14733.0, 14979.40082396692, 13835.239061851293, 13876.444942202199, 14169.716605668034, 14528.782068268772, 15437.372217528648, 13161.934190328988, 13245.80131298012, 14023.929880350533, 14207.431702731776, 14630.561083167522, 13835.861641383457, 14057.156570605797, 14225.217613031382, 14264.780645354045, 15084.773728394302, 11188.1608879336, 11541.480633371686, 11985.520579176735, 12240.632781016584, 12297.200681956003, 11204.607838725606, 11309.79657707582, 11843.467043983213, 11921.880781192423, 11961.0], "value": 7199.555141226381, "unit": "score"}], "name": "dromaeo_css", "value": 7039.186541035661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 112.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 122.0, 159.0, 128.0, 123.0, 122.0, 123.0, 146.0, 122.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 122.0, 76.0, 76.0, 76.0, 76.0, 92.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 83.0, 83.0, 83.0, 98.0, 83.0, 83.0, 100.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 51.0, 52.0, 52.0, 54.0, 54.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 81.0, 82.0, 82.0, 81.0, 81.0, 81.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 141.0, 139.0, 139.0, 137.0, 132.0, 138.0, 181.0, 130.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 162.0, 168.0, 164.0, 162.0, 164.0, 172.0, 168.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 66.0, 64.0, 71.0, 63.0, 64.0, 64.0, 62.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1501.4000000000003, "alertThreshold": 2.0}]} 06:26:23 INFO - Return code: 0 06:26:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:26:23 INFO - # TBPL SUCCESS # 06:26:23 INFO - Running post-action listener: _resource_record_post_action 06:26:23 INFO - [mozharness: 2016-12-07 14:26:23.213543Z] Finished run-tests step (success) 06:26:23 INFO - Running post-run listener: _resource_record_post_run 06:26:23 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 36864; Write bytes: 398295040; Read time: 428; Write time: 283692 06:26:23 INFO - TinderboxPrint: CPU usage
13.1% 06:26:23 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 428 06:26:23 INFO - TinderboxPrint: I/O write bytes / time
398,295,040 / 283,692 06:26:23 INFO - TinderboxPrint: CPU idle
8,310.3 (86.9%) 06:26:23 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 06:26:23 INFO - TinderboxPrint: Swap in / out
0 / 0 06:26:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103985152; Read time: 224; Write time: 110780 06:26:23 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 28672; Write bytes: 294309888; Read time: 192; Write time: 172912 06:26:23 INFO - Running post-run listener: _upload_blobber_files 06:26:23 INFO - Blob upload gear active. 06:26:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:26:23 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 06:26:23 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:26:23 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:26:24 INFO - (blobuploader) - INFO - Open directory for files ... 06:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:25 INFO - (blobuploader) - INFO - Done attempting. 06:26:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:26:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:26:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:26 INFO - (blobuploader) - INFO - Done attempting. 06:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:26:32 INFO - (blobuploader) - INFO - Done attempting. 06:26:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:26:32 INFO - Return code: 0 06:26:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:26:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:26:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37d10946eb9efa77cafe675da08e14f8a59ebb7611853b9a5bdb4cb2a2c1e613d641bf337dd10d78e92f67b97ca3255cdfdbce261bfd709bac91bcd2dac5a09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19aa062145d5e07f0a73285bba93be6574fed2b92947f745c339aac9c03df685b2275fc285fe8a53c850ab0320113f9fd032e0c41720ded1a2feb62974c9f3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f48c2b009d3709ace92ef494fea93b2d746413595c74a72814a3ec93725548a1516c48296f9f9a3808897171f740ad513c8f8a8378b6ec3158900098a317e8"} 06:26:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:26:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:26:32 INFO - Contents: 06:26:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37d10946eb9efa77cafe675da08e14f8a59ebb7611853b9a5bdb4cb2a2c1e613d641bf337dd10d78e92f67b97ca3255cdfdbce261bfd709bac91bcd2dac5a09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19aa062145d5e07f0a73285bba93be6574fed2b92947f745c339aac9c03df685b2275fc285fe8a53c850ab0320113f9fd032e0c41720ded1a2feb62974c9f3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f48c2b009d3709ace92ef494fea93b2d746413595c74a72814a3ec93725548a1516c48296f9f9a3808897171f740ad513c8f8a8378b6ec3158900098a317e8"} 06:26:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:26:32 INFO - Copying logs to upload dir... 06:26:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:26:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.312268 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-07 06:26:31.528341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 06:26:31.531978) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37d10946eb9efa77cafe675da08e14f8a59ebb7611853b9a5bdb4cb2a2c1e613d641bf337dd10d78e92f67b97ca3255cdfdbce261bfd709bac91bcd2dac5a09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19aa062145d5e07f0a73285bba93be6574fed2b92947f745c339aac9c03df685b2275fc285fe8a53c850ab0320113f9fd032e0c41720ded1a2feb62974c9f3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f48c2b009d3709ace92ef494fea93b2d746413595c74a72814a3ec93725548a1516c48296f9f9a3808897171f740ad513c8f8a8378b6ec3158900098a317e8"} build_url:https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/f_oqT8JwRh6ryB_FUXT0Ag/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37d10946eb9efa77cafe675da08e14f8a59ebb7611853b9a5bdb4cb2a2c1e613d641bf337dd10d78e92f67b97ca3255cdfdbce261bfd709bac91bcd2dac5a09", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19aa062145d5e07f0a73285bba93be6574fed2b92947f745c339aac9c03df685b2275fc285fe8a53c850ab0320113f9fd032e0c41720ded1a2feb62974c9f3ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2f48c2b009d3709ace92ef494fea93b2d746413595c74a72814a3ec93725548a1516c48296f9f9a3808897171f740ad513c8f8a8378b6ec3158900098a317e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 06:26:31.557670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:26:31.558021) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1481118385.643834-786400227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 06:26:31.640357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 06:26:31.640760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 06:26:31.641109) ========= ========= Total master_lag: 0.16 =========