builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1482359964.51 results: success (0) buildid: 20161221133153 builduid: 7aac1914e8eb4f528158b5cadd0348de revision: 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.506280) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.506749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.507074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.521542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.521881) ========= 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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 14:39:24-- 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% 42.5M=0s 2016-12-21 14:39:24 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109379 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.645267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.645598) ========= 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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021979 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:24.695084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 14:39:24.695443) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 --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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 14:39:24,878 truncating revision to first 12 chars 2016-12-21 14:39:24,878 Setting DEBUG logging. 2016-12-21 14:39:24,878 attempt 1/10 2016-12-21 14:39:24,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/38e67fedc9a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 14:39:25,549 unpacking tar archive at: graphics-38e67fedc9a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 14:39:25.743059) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:25.743401) ========= script_repo_revision: 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:25.743797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:25.744087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 14:39:25.753292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-21 14:39:25.753688) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:26 INFO - MultiFileLogger online at 20161221 14:39:26 in /builds/slave/test 14:39:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 14:39:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:26 INFO - {'append_to_log': False, 14:39:26 INFO - 'base_work_dir': '/builds/slave/test', 14:39:26 INFO - 'blob_upload_branch': 'Graphics', 14:39:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:26 INFO - 'branch': 'Graphics', 14:39:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:26 INFO - 'config_files': ('talos/linux_config.py',), 14:39:26 INFO - 'default_actions': ('clobber', 14:39:26 INFO - 'read-buildbot-config', 14:39:26 INFO - 'download-and-extract', 14:39:26 INFO - 'populate-webroot', 14:39:26 INFO - 'create-virtualenv', 14:39:26 INFO - 'install', 14:39:26 INFO - 'run-tests'), 14:39:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:26 INFO - 'download_minidump_stackwalk': True, 14:39:26 INFO - 'download_symbols': 'ondemand', 14:39:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:26 INFO - 'installer_path': 'installer.exe', 14:39:26 INFO - 'log_level': 'info', 14:39:26 INFO - 'log_name': 'talos', 14:39:26 INFO - 'log_to_console': True, 14:39:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:26 INFO - 'opt_config_files': (), 14:39:26 INFO - 'pip_index': False, 14:39:26 INFO - 'sps_profile': False, 14:39:26 INFO - 'sps_profile_interval': 0, 14:39:26 INFO - 'suite': 'dromaeojs', 14:39:26 INFO - 'system_bits': '32', 14:39:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:26 INFO - 'title': 'talos-linux64-ix-058', 14:39:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:26 INFO - 'use_talos_json': True, 14:39:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:26 INFO - 'work_dir': 'build'} 14:39:26 INFO - [mozharness: 2016-12-21 22:39:26.041232Z] Running clobber step. 14:39:26 INFO - Running pre-action listener: _resource_record_pre_action 14:39:26 INFO - Running main action method: clobber 14:39:26 INFO - rmtree: /builds/slave/test/build 14:39:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:27 INFO - Running post-action listener: _resource_record_post_action 14:39:27 INFO - [mozharness: 2016-12-21 22:39:27.135852Z] Finished clobber step (success) 14:39:27 INFO - [mozharness: 2016-12-21 22:39:27.135952Z] Running read-buildbot-config step. 14:39:27 INFO - Running pre-action listener: _resource_record_pre_action 14:39:27 INFO - Running main action method: read_buildbot_config 14:39:27 INFO - Using buildbot properties: 14:39:27 INFO - { 14:39:27 INFO - "project": "", 14:39:27 INFO - "product": "firefox", 14:39:27 INFO - "script_repo_revision": "default", 14:39:27 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 14:39:27 INFO - "repository": "", 14:39:27 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 14:39:27 INFO - "buildid": "20161221133153", 14:39:27 INFO - "pgo_build": "False", 14:39:27 INFO - "basedir": "/builds/slave/test", 14:39:27 INFO - "buildnumber": 31, 14:39:27 INFO - "slavename": "talos-linux64-ix-058", 14:39:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:39:27 INFO - "platform": "ubuntu64_hw", 14:39:27 INFO - "scheduler": "tests-graphics-linux64-talos", 14:39:27 INFO - "branch": "graphics", 14:39:27 INFO - "repo_path": "projects/graphics", 14:39:27 INFO - "revision": "38e67fedc9a71c3b726cf875ac114ba5a6593fc8", 14:39:27 INFO - "stage_platform": "linux64", 14:39:27 INFO - "builduid": "7aac1914e8eb4f528158b5cadd0348de", 14:39:27 INFO - "slavebuilddir": "test" 14:39:27 INFO - } 14:39:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:39:27 INFO - Running post-action listener: _resource_record_post_action 14:39:27 INFO - [mozharness: 2016-12-21 22:39:27.138401Z] Finished read-buildbot-config step (success) 14:39:27 INFO - [mozharness: 2016-12-21 22:39:27.138491Z] Running download-and-extract step. 14:39:27 INFO - Running pre-action listener: _resource_record_pre_action 14:39:27 INFO - Running main action method: download_and_extract 14:39:27 INFO - mkdir: /builds/slave/test/build/tests 14:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:27 INFO - trying https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:39:27 INFO - Downloading https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/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 14:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/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 14:39:27 INFO - Downloaded 1361 bytes. 14:39:27 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:39:27 INFO - Using the following test package requirements: 14:39:27 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:27 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:27 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:39:27 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'jsshell-linux-x86_64.zip'], 14:39:27 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:27 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:39:27 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:39:27 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:39:27 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:27 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:39:27 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:39:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:27 INFO - Fetch https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:39:28 INFO - Expected file size: 20258275 14:39:28 INFO - Obtained file size: 20258275 14:39:32 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 14:39:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:39:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:32 INFO - Fetch https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:39:33 INFO - Expected file size: 20258275 14:39:33 INFO - Obtained file size: 20258275 14:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:39:38 INFO - Expected file size: 14409734 14:39:38 INFO - Obtained file size: 14409734 14:39:38 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')]} 14:39:38 INFO - trying https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:39:38 INFO - Downloading https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/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 14:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/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 14:39:39 INFO - Downloaded 55648331 bytes. 14:39:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:39:39 INFO - mkdir: /builds/slave/test/properties 14:39:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:39 INFO - Contents: 14:39:39 INFO - build_url:https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:39:40 INFO - Running post-action listener: _resource_record_post_action 14:39:40 INFO - Running post-action listener: set_extra_try_arguments 14:39:40 INFO - [mozharness: 2016-12-21 22:39:40.619155Z] Finished download-and-extract step (success) 14:39:40 INFO - [mozharness: 2016-12-21 22:39:40.619382Z] Running populate-webroot step. 14:39:40 INFO - Running pre-action listener: _resource_record_pre_action 14:39:40 INFO - Running main action method: populate_webroot 14:39:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:40 INFO - '--tppagecycles', 14:39:40 INFO - '7'], 14:39:40 INFO - 'tests': ['tsvgm']}}, 14:39:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['damp', 'tps']}, 14:39:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'tests': ['damp', 'tps']}, 14:39:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['dromaeo_dom']}, 14:39:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['basic_compositor_video']}, 14:39:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:39:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['a11yr', 14:39:40 INFO - 'ts_paint', 14:39:40 INFO - 'tpaint', 14:39:40 INFO - 'sessionrestore', 14:39:40 INFO - 'sessionrestore_no_auto_restore', 14:39:40 INFO - 'tabpaint']}, 14:39:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['tsvgx', 14:39:40 INFO - 'tsvgr_opacity', 14:39:40 INFO - 'tart', 14:39:40 INFO - 'tscrollx', 14:39:40 INFO - 'cart', 14:39:40 INFO - 'tsvg_static']}, 14:39:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:40 INFO - 'tsvgr_opacity', 14:39:40 INFO - 'tart', 14:39:40 INFO - 'tscrollx', 14:39:40 INFO - 'cart', 14:39:40 INFO - 'tsvg_static']}, 14:39:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-e10s'], 14:39:40 INFO - 'tests': ['tp5o']}, 14:39:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:39:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--disable-e10s', 14:39:40 INFO - '--xperf_path', 14:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:40 INFO - 'tests': ['tp5n']}, 14:39:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:39:40 INFO - 'talos_options': ['--xperf_path', 14:39:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:40 INFO - 'tests': ['tp5n']}}, 14:39:40 INFO - 'talos.zip': {'path': '', 14:39:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:40 INFO - Running post-action listener: _resource_record_post_action 14:39:40 INFO - [mozharness: 2016-12-21 22:39:40.635816Z] Finished populate-webroot step (success) 14:39:40 INFO - [mozharness: 2016-12-21 22:39:40.635905Z] Running create-virtualenv step. 14:39:40 INFO - Running pre-action listener: _resource_record_pre_action 14:39:40 INFO - Running main action method: create_virtualenv 14:39:40 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:40 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 14:39:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:40 INFO - Using real prefix '/usr' 14:39:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:43 INFO - Installing pip.................done. 14:39:43 INFO - Return code: 0 14:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:43 INFO - Reading from file tmpfile_stdout 14:39:43 INFO - Output received: 14:39:43 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) 14:39:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:43 INFO - Using env: {'DISPLAY': ':0', 14:39:43 INFO - 'HOME': '/home/cltbld', 14:39:43 INFO - 'LANG': 'en_US.UTF-8', 14:39:43 INFO - 'LANGUAGE': 'en_US:en', 14:39:43 INFO - 'LOGNAME': 'cltbld', 14:39:43 INFO - 'MAIL': '/var/mail/cltbld', 14:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:43 INFO - 'MOZ_NO_REMOTE': '1', 14:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:43 INFO - 'NO_EM_RESTART': '1', 14:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:43 INFO - 'PWD': '/builds/slave/test', 14:39:43 INFO - 'SHELL': '/bin/bash', 14:39:43 INFO - 'SHLVL': '1', 14:39:43 INFO - 'TERM': 'linux', 14:39:43 INFO - 'TMOUT': '86400', 14:39:43 INFO - 'USER': 'cltbld', 14:39:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:43 INFO - '_': '/tools/buildbot/bin/python'} 14:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:43 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 14:39:43 INFO - Cleaning up... 14:39:43 INFO - Return code: 0 14:39:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:39:43 INFO - Using env: {'DISPLAY': ':0', 14:39:43 INFO - 'HOME': '/home/cltbld', 14:39:43 INFO - 'LANG': 'en_US.UTF-8', 14:39:43 INFO - 'LANGUAGE': 'en_US:en', 14:39:43 INFO - 'LOGNAME': 'cltbld', 14:39:43 INFO - 'MAIL': '/var/mail/cltbld', 14:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:43 INFO - 'MOZ_NO_REMOTE': '1', 14:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:43 INFO - 'NO_EM_RESTART': '1', 14:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:43 INFO - 'PWD': '/builds/slave/test', 14:39:43 INFO - 'SHELL': '/bin/bash', 14:39:43 INFO - 'SHLVL': '1', 14:39:43 INFO - 'TERM': 'linux', 14:39:43 INFO - 'TMOUT': '86400', 14:39:43 INFO - 'USER': 'cltbld', 14:39:43 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:43 INFO - '_': '/tools/buildbot/bin/python'} 14:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:43 INFO - Downloading/unpacking psutil>=3.1.1 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:45 INFO - Installing collected packages: psutil 14:39:45 INFO - Running setup.py install for psutil 14:39:46 INFO - building 'psutil._psutil_linux' extension 14:39:46 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 14:39:46 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 14:39:46 INFO - building 'psutil._psutil_posix' extension 14:39:46 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 14:39:46 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 14:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:46 INFO - Successfully installed psutil 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:39:46 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')]} 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 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')]} 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:46 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 14:39:46 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 14:39:46 INFO - Using env: {'DISPLAY': ':0', 14:39:46 INFO - 'HOME': '/home/cltbld', 14:39:46 INFO - 'LANG': 'en_US.UTF-8', 14:39:46 INFO - 'LANGUAGE': 'en_US:en', 14:39:46 INFO - 'LOGNAME': 'cltbld', 14:39:46 INFO - 'MAIL': '/var/mail/cltbld', 14:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:46 INFO - 'MOZ_NO_REMOTE': '1', 14:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:46 INFO - 'NO_EM_RESTART': '1', 14:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:46 INFO - 'PWD': '/builds/slave/test', 14:39:46 INFO - 'SHELL': '/bin/bash', 14:39:46 INFO - 'SHLVL': '1', 14:39:46 INFO - 'TERM': 'linux', 14:39:46 INFO - 'TMOUT': '86400', 14:39:46 INFO - 'USER': 'cltbld', 14:39:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:46 INFO - '_': '/tools/buildbot/bin/python'} 14:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:48 INFO - Installing collected packages: mozsystemmonitor 14:39:48 INFO - Running setup.py install for mozsystemmonitor 14:39:48 INFO - Successfully installed mozsystemmonitor 14:39:48 INFO - Cleaning up... 14:39:48 INFO - Return code: 0 14:39:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:49 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:49 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 14:39:49 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 14:39:49 INFO - Using env: {'DISPLAY': ':0', 14:39:49 INFO - 'HOME': '/home/cltbld', 14:39:49 INFO - 'LANG': 'en_US.UTF-8', 14:39:49 INFO - 'LANGUAGE': 'en_US:en', 14:39:49 INFO - 'LOGNAME': 'cltbld', 14:39:49 INFO - 'MAIL': '/var/mail/cltbld', 14:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:49 INFO - 'MOZ_NO_REMOTE': '1', 14:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:49 INFO - 'NO_EM_RESTART': '1', 14:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:49 INFO - 'PWD': '/builds/slave/test', 14:39:49 INFO - 'SHELL': '/bin/bash', 14:39:49 INFO - 'SHLVL': '1', 14:39:49 INFO - 'TERM': 'linux', 14:39:49 INFO - 'TMOUT': '86400', 14:39:49 INFO - 'USER': 'cltbld', 14:39:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:49 INFO - '_': '/tools/buildbot/bin/python'} 14:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:49 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:49 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 14:39:49 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 14:39:49 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 14:39:49 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 14:39:49 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 14:39:49 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 14:39:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 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 14:39:51 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:51 INFO - warning: no files found matching '*.txt' 14:39:51 INFO - no previously-included directories found matching 'build' 14:39:51 INFO - no previously-included directories found matching 'dist' 14:39:51 INFO - no previously-included directories found matching '.git*' 14:39:51 INFO - Installing collected packages: jsonschema, functools32 14:39:51 INFO - Running setup.py install for functools32 14:39:51 INFO - warning: no files found matching '*.txt' 14:39:51 INFO - no previously-included directories found matching 'build' 14:39:51 INFO - no previously-included directories found matching 'dist' 14:39:51 INFO - no previously-included directories found matching '.git*' 14:39:51 INFO - Successfully installed jsonschema functools32 14:39:51 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39:51 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')]} 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 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')]} 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:51 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 14:39:51 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 14:39:51 INFO - Using env: {'DISPLAY': ':0', 14:39:51 INFO - 'HOME': '/home/cltbld', 14:39:51 INFO - 'LANG': 'en_US.UTF-8', 14:39:51 INFO - 'LANGUAGE': 'en_US:en', 14:39:51 INFO - 'LOGNAME': 'cltbld', 14:39:51 INFO - 'MAIL': '/var/mail/cltbld', 14:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:51 INFO - 'MOZ_NO_REMOTE': '1', 14:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:51 INFO - 'NO_EM_RESTART': '1', 14:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:51 INFO - 'PWD': '/builds/slave/test', 14:39:51 INFO - 'SHELL': '/bin/bash', 14:39:51 INFO - 'SHLVL': '1', 14:39:51 INFO - 'TERM': 'linux', 14:39:51 INFO - 'TMOUT': '86400', 14:39:51 INFO - 'USER': 'cltbld', 14:39:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:51 INFO - '_': '/tools/buildbot/bin/python'} 14:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:51 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:51 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')]} 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 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')]} 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:51 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 14:39:51 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 14:39:51 INFO - Using env: {'DISPLAY': ':0', 14:39:51 INFO - 'HOME': '/home/cltbld', 14:39:51 INFO - 'LANG': 'en_US.UTF-8', 14:39:51 INFO - 'LANGUAGE': 'en_US:en', 14:39:51 INFO - 'LOGNAME': 'cltbld', 14:39:51 INFO - 'MAIL': '/var/mail/cltbld', 14:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:51 INFO - 'MOZ_NO_REMOTE': '1', 14:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:51 INFO - 'NO_EM_RESTART': '1', 14:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:51 INFO - 'PWD': '/builds/slave/test', 14:39:51 INFO - 'SHELL': '/bin/bash', 14:39:51 INFO - 'SHLVL': '1', 14:39:51 INFO - 'TERM': 'linux', 14:39:51 INFO - 'TMOUT': '86400', 14:39:51 INFO - 'USER': 'cltbld', 14:39:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:51 INFO - '_': '/tools/buildbot/bin/python'} 14:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:52 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:52 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 14:39:52 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 14:39:52 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 14:39:52 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 14:39:52 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 14:39:52 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 14:39:54 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 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 14:39:54 INFO - Downloading docopt-0.6.1.tar.gz 14:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:54 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:54 INFO - Running setup.py install for blobuploader 14:39:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:55 INFO - Running setup.py install for requests 14:39:55 INFO - Running setup.py install for docopt 14:39:55 INFO - Successfully installed blobuploader requests docopt 14:39:55 INFO - Cleaning up... 14:39:55 INFO - Return code: 0 14:39:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:55 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:55 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 14:39:55 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 14:39:55 INFO - Using env: {'DISPLAY': ':0', 14:39:55 INFO - 'HOME': '/home/cltbld', 14:39:55 INFO - 'LANG': 'en_US.UTF-8', 14:39:55 INFO - 'LANGUAGE': 'en_US:en', 14:39:55 INFO - 'LOGNAME': 'cltbld', 14:39:55 INFO - 'MAIL': '/var/mail/cltbld', 14:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:55 INFO - 'MOZ_NO_REMOTE': '1', 14:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:55 INFO - 'NO_EM_RESTART': '1', 14:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:55 INFO - 'PWD': '/builds/slave/test', 14:39:55 INFO - 'SHELL': '/bin/bash', 14:39:55 INFO - 'SHLVL': '1', 14:39:55 INFO - 'TERM': 'linux', 14:39:55 INFO - 'TMOUT': '86400', 14:39:55 INFO - 'USER': 'cltbld', 14:39:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:55 INFO - '_': '/tools/buildbot/bin/python'} 14:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:55 INFO - Running setup.py (path:/tmp/pip-uqG_qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:55 INFO - Running setup.py (path:/tmp/pip-nMbLwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:55 INFO - Running setup.py (path:/tmp/pip-jG_fnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:56 INFO - Running setup.py (path:/tmp/pip-H1cCNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:56 INFO - Running setup.py (path:/tmp/pip-cNMUa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:56 INFO - Running setup.py (path:/tmp/pip-ehEQyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:56 INFO - Running setup.py (path:/tmp/pip-g3PwIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:56 INFO - Running setup.py (path:/tmp/pip-8zki8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:56 INFO - Running setup.py (path:/tmp/pip-tkZ_OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:56 INFO - Running setup.py (path:/tmp/pip-D46_z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:56 INFO - Running setup.py (path:/tmp/pip-cPxjr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:56 INFO - Running setup.py (path:/tmp/pip-yQIc6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:56 INFO - Running setup.py (path:/tmp/pip-Cn5Ebq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:56 INFO - Running setup.py (path:/tmp/pip-FU03TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:56 INFO - Running setup.py (path:/tmp/pip-vtvqQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:56 INFO - Running setup.py (path:/tmp/pip-NfZdwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:56 INFO - Running setup.py (path:/tmp/pip-aJ7JaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:57 INFO - Running setup.py install for manifestparser 14:39:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Running setup.py install for mozcrash 14:39:57 INFO - Running setup.py install for mozdebug 14:39:57 INFO - Running setup.py install for mozdevice 14:39:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Running setup.py install for mozfile 14:39:57 INFO - Running setup.py install for mozhttpd 14:39:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Running setup.py install for mozinfo 14:39:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Running setup.py install for mozInstall 14:39:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Running setup.py install for mozleak 14:39:57 INFO - Running setup.py install for mozlog 14:39:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for moznetwork 14:39:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozprocess 14:39:58 INFO - Running setup.py install for mozprofile 14:39:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozrunner 14:39:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Running setup.py install for mozscreenshot 14:39:58 INFO - Running setup.py install for moztest 14:39:58 INFO - Running setup.py install for mozversion 14:39:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:58 INFO - Cleaning up... 14:39:58 INFO - Return code: 0 14:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:58 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:39:58 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 14:39:58 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 14:39:58 INFO - Using env: {'DISPLAY': ':0', 14:39:58 INFO - 'HOME': '/home/cltbld', 14:39:58 INFO - 'LANG': 'en_US.UTF-8', 14:39:58 INFO - 'LANGUAGE': 'en_US:en', 14:39:58 INFO - 'LOGNAME': 'cltbld', 14:39:58 INFO - 'MAIL': '/var/mail/cltbld', 14:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:58 INFO - 'MOZ_NO_REMOTE': '1', 14:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:58 INFO - 'NO_EM_RESTART': '1', 14:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:58 INFO - 'PWD': '/builds/slave/test', 14:39:58 INFO - 'SHELL': '/bin/bash', 14:39:58 INFO - 'SHLVL': '1', 14:39:58 INFO - 'TERM': 'linux', 14:39:58 INFO - 'TMOUT': '86400', 14:39:58 INFO - 'USER': 'cltbld', 14:39:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:58 INFO - '_': '/tools/buildbot/bin/python'} 14:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:59 INFO - Running setup.py (path:/tmp/pip-QErsbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:59 INFO - Running setup.py (path:/tmp/pip-iRdwUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:59 INFO - Running setup.py (path:/tmp/pip-VLQfIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:59 INFO - Running setup.py (path:/tmp/pip-IKVb1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:59 INFO - Running setup.py (path:/tmp/pip-mlCgnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:59 INFO - Running setup.py (path:/tmp/pip-OtICBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:59 INFO - Running setup.py (path:/tmp/pip-vN6Fjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:59 INFO - Running setup.py (path:/tmp/pip-Y5tUL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:59 INFO - Running setup.py (path:/tmp/pip-zx0f2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:59 INFO - Running setup.py (path:/tmp/pip-iE7Pk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:59 INFO - Running setup.py (path:/tmp/pip-eLvHES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:59 INFO - Running setup.py (path:/tmp/pip-uLwA1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:59 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)) 14:39:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:59 INFO - Running setup.py (path:/tmp/pip-Ql2fti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:00 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)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:00 INFO - Running setup.py (path:/tmp/pip-xalP7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:00 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)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:00 INFO - Running setup.py (path:/tmp/pip-EJjXQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:00 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)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:00 INFO - Running setup.py (path:/tmp/pip-Br9mgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:00 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)) 14:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:00 INFO - Running setup.py (path:/tmp/pip-lMRn1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 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)) 14:40:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:02 INFO - Downloading blessings-1.6.tar.gz 14:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:02 INFO - Installing collected packages: blessings 14:40:02 INFO - Running setup.py install for blessings 14:40:02 INFO - Successfully installed blessings 14:40:02 INFO - Cleaning up... 14:40:02 INFO - Return code: 0 14:40:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:02 INFO - Reading from file tmpfile_stdout 14:40:02 INFO - Current package versions: 14:40:02 INFO - argparse == 1.2.1 14:40:02 INFO - blessings == 1.6 14:40:02 INFO - blobuploader == 1.2.4 14:40:02 INFO - docopt == 0.6.1 14:40:02 INFO - functools32 == 3.2.3-2 14:40:02 INFO - jsonschema == 2.5.1 14:40:02 INFO - manifestparser == 1.1 14:40:02 INFO - mozInstall == 1.12 14:40:02 INFO - mozcrash == 1.0 14:40:02 INFO - mozdebug == 0.1 14:40:02 INFO - mozdevice == 0.49 14:40:02 INFO - mozfile == 1.2 14:40:02 INFO - mozhttpd == 0.7 14:40:02 INFO - mozinfo == 0.9 14:40:02 INFO - mozleak == 0.1 14:40:02 INFO - mozlog == 3.4 14:40:02 INFO - moznetwork == 0.27 14:40:02 INFO - mozprocess == 0.23 14:40:02 INFO - mozprofile == 0.28 14:40:02 INFO - mozrunner == 6.13 14:40:02 INFO - mozscreenshot == 0.1 14:40:02 INFO - mozsystemmonitor == 0.3 14:40:02 INFO - moztest == 0.7 14:40:02 INFO - mozversion == 1.4 14:40:02 INFO - psutil == 3.1.1 14:40:02 INFO - requests == 1.2.3 14:40:02 INFO - wsgiref == 0.1.2 14:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:02 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')]} 14:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:02 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')]} 14:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:02 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:40:02 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 14:40:02 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 14:40:02 INFO - Using env: {'DISPLAY': ':0', 14:40:02 INFO - 'HOME': '/home/cltbld', 14:40:02 INFO - 'LANG': 'en_US.UTF-8', 14:40:02 INFO - 'LANGUAGE': 'en_US:en', 14:40:02 INFO - 'LOGNAME': 'cltbld', 14:40:02 INFO - 'MAIL': '/var/mail/cltbld', 14:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:02 INFO - 'MOZ_NO_REMOTE': '1', 14:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:02 INFO - 'NO_EM_RESTART': '1', 14:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:02 INFO - 'PWD': '/builds/slave/test', 14:40:02 INFO - 'SHELL': '/bin/bash', 14:40:02 INFO - 'SHLVL': '1', 14:40:02 INFO - 'TERM': 'linux', 14:40:02 INFO - 'TMOUT': '86400', 14:40:02 INFO - 'USER': 'cltbld', 14:40:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:02 INFO - '_': '/tools/buildbot/bin/python'} 14:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 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)) 14:40:03 INFO - Cleaning up... 14:40:03 INFO - Return code: 0 14:40:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2386c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, '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': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', '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 14:40: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', 'jsonschema'] in /builds/slave/test/build 14:40: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 jsonschema 14:40:03 INFO - Using env: {'DISPLAY': ':0', 14:40:03 INFO - 'HOME': '/home/cltbld', 14:40:03 INFO - 'LANG': 'en_US.UTF-8', 14:40:03 INFO - 'LANGUAGE': 'en_US:en', 14:40:03 INFO - 'LOGNAME': 'cltbld', 14:40:03 INFO - 'MAIL': '/var/mail/cltbld', 14:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:03 INFO - 'MOZ_NO_REMOTE': '1', 14:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:03 INFO - 'NO_EM_RESTART': '1', 14:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:03 INFO - 'PWD': '/builds/slave/test', 14:40:03 INFO - 'SHELL': '/bin/bash', 14:40:03 INFO - 'SHLVL': '1', 14:40:03 INFO - 'TERM': 'linux', 14:40:03 INFO - 'TMOUT': '86400', 14:40:03 INFO - 'USER': 'cltbld', 14:40:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:03 INFO - '_': '/tools/buildbot/bin/python'} 14:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:40:03 INFO - Cleaning up... 14:40:03 INFO - Return code: 0 14:40:03 INFO - Running post-action listener: _resource_record_post_action 14:40:03 INFO - Running post-action listener: _start_resource_monitoring 14:40:03 INFO - Starting resource monitoring. 14:40:03 INFO - [mozharness: 2016-12-21 22:40:03.307260Z] Finished create-virtualenv step (success) 14:40:03 INFO - [mozharness: 2016-12-21 22:40:03.307747Z] Running install step. 14:40:03 INFO - Running pre-action listener: _resource_record_pre_action 14:40:03 INFO - Running main action method: install 14:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:03 INFO - Reading from file tmpfile_stdout 14:40:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:03 INFO - Reading from file tmpfile_stdout 14:40:03 INFO - Output received: 14:40:03 INFO - Usage: mozinstall [options] installer 14:40:03 INFO - Options: 14:40:03 INFO - -h, --help show this help message and exit 14:40:03 INFO - -d DEST, --destination=DEST 14:40:03 INFO - Directory to install application into. [default: 14:40:03 INFO - "/builds/slave/test"] 14:40:03 INFO - --app=APP Application being installed. [default: firefox] 14:40:03 INFO - mkdir: /builds/slave/test/build/application 14:40:03 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'] 14:40:03 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 14:40:19 INFO - Reading from file tmpfile_stdout 14:40:19 INFO - Output received: 14:40:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:19 INFO - Running post-action listener: _resource_record_post_action 14:40:19 INFO - [mozharness: 2016-12-21 22:40:19.673016Z] Finished install step (success) 14:40:19 INFO - [mozharness: 2016-12-21 22:40:19.673162Z] Running run-tests step. 14:40:19 INFO - Running pre-action listener: _resource_record_pre_action 14:40:19 INFO - Running main action method: run_tests 14:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:19 INFO - Python 2.7.3 14:40:19 INFO - Return code: 0 14:40:19 INFO - grabbing minidump binary from tooltool 14:40: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')]} 14:40:19 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 0x23843f0>, '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 0x2384cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23851a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:19 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 14:40:19 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 14:40:19 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 14:40:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:19 INFO - Return code: 0 14:40:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 14:40:19 INFO - Using env: {'DISPLAY': ':0', 14:40:19 INFO - 'HOME': '/home/cltbld', 14:40:19 INFO - 'LANG': 'en_US.UTF-8', 14:40:19 INFO - 'LANGUAGE': 'en_US:en', 14:40:19 INFO - 'LOGNAME': 'cltbld', 14:40:19 INFO - 'MAIL': '/var/mail/cltbld', 14:40:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:19 INFO - 'MOZ_NO_REMOTE': '1', 14:40:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:19 INFO - 'NO_EM_RESTART': '1', 14:40:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:19 INFO - 'PWD': '/builds/slave/test', 14:40:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:19 INFO - 'SHELL': '/bin/bash', 14:40:19 INFO - 'SHLVL': '1', 14:40:19 INFO - 'TERM': 'linux', 14:40:19 INFO - 'TMOUT': '86400', 14:40:19 INFO - 'USER': 'cltbld', 14:40:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903', 14:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:19 INFO - '_': '/tools/buildbot/bin/python'} 14:40:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 14:40:19 INFO - mozversion application_buildid: 20161221133153 14:40:19 INFO - mozversion application_changeset: 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 14:40:19 INFO - mozversion application_display_name: Nightly 14:40:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:19 INFO - mozversion application_name: Firefox 14:40:19 INFO - mozversion application_remotingname: firefox 14:40:19 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:40:19 INFO - mozversion application_vendor: Mozilla 14:40:19 INFO - mozversion application_version: 53.0a1 14:40:19 INFO - mozversion platform_buildid: 20161221133153 14:40:19 INFO - mozversion platform_changeset: 38e67fedc9a71c3b726cf875ac114ba5a6593fc8 14:40:19 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:40:19 INFO - mozversion platform_version: 53.0a1 14:40:19 INFO - using testdate: 1482360019 14:40:19 INFO - actual date: 1482360019 14:40:19 INFO - starting webserver on 'localhost:33029' 14:40:19 INFO - SUITE-START | Running 2 tests 14:40:19 INFO - TEST-START | dromaeo_css 14:40:19 INFO - operating with platform_type : linux_ 14:40:19 INFO - Initialising browser for dromaeo_css test... 14:40:19 INFO - TEST-INFO | started process 15126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHMfRo/profile http://localhost:33029/getInfo.html) 14:40:24 INFO - PROCESS | 15126 | __metrics Screen width/height:1600/1200 14:40:24 INFO - PROCESS | 15126 | colorDepth:24 14:40:24 INFO - PROCESS | 15126 | Browser inner width/height: 1024/697 14:40:24 INFO - PROCESS | 15126 | __metrics 14:40:24 INFO - PROCESS | 15126 | 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" 14:40:24 INFO - PROCESS | 15126 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:25 INFO - PROCESS | 15126 | console.error: PushService: 14:40:25 INFO - PROCESS | 15126 | stateChangeProcessEnqueue: Error transitioning state 14:40:25 INFO - PROCESS | 15126 | UnknownError 14:40:25 INFO - TEST-INFO | 15126: exit 0 14:40:25 INFO - Browser initialized. 14:40:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:25 INFO - TEST-INFO | started process 15209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaHMfRo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:37 INFO - PROCESS | 15209 | RSS: Main: 155512832 14:40:37 INFO - PROCESS | 15209 | 14:41:28 INFO - PROCESS | 15209 | 1482360088801 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] 14:43:43 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33029/tests/dromaeo/cssquery-ext.html) 14:43:45 INFO - PROCESS | 15209 | RSS: Main: 300806144 14:43:45 INFO - PROCESS | 15209 | 14:46:47 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-ext.html (next: http://localhost:33029/tests/dromaeo/cssquery-jquery.html) 14:46:48 INFO - PROCESS | 15209 | RSS: Main: 244568064 14:46:48 INFO - PROCESS | 15209 | 14:49:51 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33029/tests/dromaeo/cssquery-mootools.html) 14:49:51 INFO - PROCESS | 15209 | RSS: Main: 189878272 14:49:51 INFO - PROCESS | 15209 | 14:52:53 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33029/tests/dromaeo/cssquery-prototype.html) 14:52:54 INFO - PROCESS | 15209 | RSS: Main: 192155648 14:52:54 INFO - PROCESS | 15209 | 14:55:57 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33029/tests/dromaeo/cssquery-yui.html) 14:55:58 INFO - PROCESS | 15209 | RSS: Main: 191614976 14:55:58 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | Cycle 1(1): loaded http://localhost:33029/tests/dromaeo/cssquery-yui.html (next: http://localhost:33029/tests/dromaeo/cssquery-dojo.html) 14:59:01 INFO - PROCESS | 15209 | RSS: Main: 282341376 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | __start_tp_report 14:59:01 INFO - PROCESS | 15209 | _x_x_mozilla_page_load 14:59:01 INFO - PROCESS | 15209 | _x_x_mozilla_page_load_details 14:59:01 INFO - PROCESS | 15209 | |i|pagename|runs| 14:59:01 INFO - PROCESS | 15209 | |0;dojo.html;2613.216035189443;2618.633391325214;2656.880440380183;2674.184373766002;2683.0609286749627;4667.39323887895;4735.171345014626;4754.453237877645;4840.44334901486;4866.24573191155;4747.28790681398;4821.180399332113;4854.56308932196;4892.486288939664;4920.409550853902;4387.758673272969;4403.801828917691;4408.030233348674;4431.778411079449;4482.529334419888;4448.998975230579;4489.775511224442;4507.2788353863225;4528.094381123772;4558.27067669173;4435.955640443619;4478.910421791578;4479.843205487792;4493.775311234425;4515.819367225307;4272.166927449118;4304.935425968613;4310.78446077698;4362.1275744851155;4362.192994296065;4387.714798538085;4389.5390983946545;4449.243628583149;4449.933251001237;4465.084657645208;4751.239801631722;4781.737004464753;4810.11012962603;4812.389512735616;4868.196747536652;5017.974910125463;5062.493750624945;5064.3163172971545;5186.5850731941355;5196.428392876781;5095.388553373619;5170.017696637627;5177.559907407875;5215.843524694265;5262.7631756571045;4839.080574690797;4840.540148685869;4850.102730994707;4852.636052296092;4898.461169271377;5198.792048318101;5313.521783039545;5323.600729945269;5325.307709997753;5325.547328477122;5006.89986200274;5052.520010598987;5080.949190508048;5094;5097.184450487978;5189.429162792166;5197.272381866542;5197.896042079137;5200.427952925175;5238.790448382022;5107.489251074863;5137.897242055138;5157.561607263425;5160.045391602565;5205.713685747244;4945.876353091129;4962.429320628102;4965.4041515018425;5020.673656212408;5116.641835071509;4385.473743150842;4405.977970110129;4408.184485870124;4411.911761764747;4417;3841.4237864320016;3845.9230815383535;3869.806509674505;3873.845046198177;3887.1448281378052;4417.602415782595;4419.0719948810465;4419.11617676466;4423;4457.130859482435;4946.258061290763;4947;4953.108440480676;5170.302009228782;5209.0363282792805;4386.912261754747;4421.115776844644;4423.336499525097;4432.645388368923;4471.7987690554;4680.625549955996;4694.50707675696;4694.694844835075;4696.577308042224;4700.341952126705;4596.678232523691;4789.640776941674;4799.832005879777;4800.807967681254;4805.8077676892535;4994.900101998012;5076.517730815566;5139.331886854835;5206.791728330824;5212.921806172986;4819.2530157825595;4830.347903033045;4830.855074347775;4841.394825646794;4884.7069175849565;5137.8972420550635;5141.5629671476845;5141.948580514147;5145.022445735298;5145.279660847559;5013.523715247045;5048.167052436307;5053.343065401475;5118.38579370478;5124.820631278037;4983.626228032839;4986.102501549756;5030;5053.84838454847;5104.719240441811;5033.270175824412;5042.647014709082;5045.5459008689395;5046.873828154326;5050.242463630338;4752.500987396412;4965.081459929925;4968.155413579628;4974.925376119433;4977.377827771528;4879.04858552593;5010.273510341053;5037.722925239147;5048.343715316985;5122.641415101056;4803.303520989507;4838.153323168502;4921.064997650435;4928.6057115431395;4975.676581022367 14:59:01 INFO - PROCESS | 15209 | |1;ext.html;524.4100387064552;544.6976927805069;555.6666000399758;561.0882316236115;569.7436153730822;27907.581386279224;36359;37867.43198852019;37897.621023789754;41672;39478.21043579127;39960;40046.39930401046;40077.198456030936;40097;7206.063211782487;7514.323710866035;7737.458377913548;7748.41886858485;7754.8449031019345;7214.458915581326;9619.326647134669;9868.851967220497;9880.505974701236;10179.083882450577;9395.201407880339;9436.433813971149;9441.858372124423;9444.952775236114;9447.338686291961;9692;9739.220862330996;9745.415275083518;9760.07279308468;9761.560729767178;9689.90310096897;9748.561314740853;9748.658796942143;9758.219342452587;9766.755831104208;37685.24629507394;37965.62034379649;38009.239815203815;38060;38067.04832379185;2908;2909.9854500727574;3061.3877224555176;3217.9678203218136;3507.6141624421293;26202.213933582025;26698.466030679472;26746.331341716417;26772.732272677218;26813.195604131906;3344.823818086074;3444.5866496020385;3462.8961131166106;3480.9303813923834;3511.7717348372275;241829;241955;243107;243276.78361608257;243545;51657.48342516602;51827.48172518227;52021;52133.478665213624;52186.73906630443;54978;55041.44958550363;55135.44864551383;55357;55414.44585554174;13798.379072941741;14001.299935003413;14028.08817426864;14038.36827342772;14099.859001409855;9613.423194608205;9840.95079524612;10478.476076196159;10755.354678719303;10904.61833835812;15596.220188990505;16313.42902998413;16340.18299085041;16473.505794826175;16491.17544122813;5751.309842818889;5789.189513468118;5794.913076303858;5911.438413350725;6014.278286605635;703.2896774258036;772.6252767407802;846.5217152308926;952.5332587032443;976.2434113562047;25870.6119408209;26877.193684189504;26888.865555672095;27319.863400683265;27347.589786153225;893.8569828827357;935.2284365398573;964.6961207219704;973.3721749471551;1000.1946486591771;13940.930295348458;14285.857141428452;14500.274986250644;14576.198309093103;14769;310813;311498;313879;314157;316410;45222.54777452249;45365.63903082913;45419.77290113594;45438.54561454409;45500.77249613731;1030.443560477334;1052.6841947415899;1088.9727756805985;1094.1137678480457;1146.306484576819;26145.607815882395;27339.589906151024;27705.53691275171;27944.860275699306;28321.433571328045;40032.79983600063;40579.79710101431;40632;40661.59338406578;40679.59320406876;270889;271976;272479;272656;272821;21855.3443396692;22673.39255985517;22715.659265110706;23783.405414864075;24060.51878962376;34636;34737.82631086828;35137.648623513436;35368.823155884056;35790.821045894605;29964.850175748983;30329;30518.237044074074;30555;30935.381292374477;30066.24834379158;30175.245618859703;30539.54190687186;31062.68937310598;31588.526172106976;30138.69861301359;30198.547021794253;30366;33781.324373512885;34766.13084672904;26760.33099172536;27950.02174923868;28563;28994.7100528992;29028;21587.352379428015;22044.669329959743;22149;22591.322260332217;24320.75679243185 14:59:01 INFO - PROCESS | 15209 | |2;jquery.html;339.54673995300124;367.4488267598602;369.4200105833841;372.61620530853224;388.53764020815225;12343.259404435728;15710.450134245304;15917.920410397932;17168.656626867487;17340.393086241984;14907.676773735631;15069.2465376731;16725.916370418163;16826.24281907314;16993.2353044113;4771.928421073687;4849.975750121253;4978.103941290567;5004.874878128039;5016.172331565287;3639.3813051781262;3813.9618603813883;4967.70193788372;5066.417362003362;5068.5438310552045;5600.5799565032785;5856.414358564152;5868.618539794921;5968.612040217372;5977.521798256129;5780.50865676418;5924.851878703023;5954.31525374581;5966.075258334965;5981.461668449861;5271.578273738091;5272.762725677354;5278.524932756032;5280.2607634930755;5280.656757310762;20087.49781255466;20230.898845505824;20384.796152038438;20385.4903627409;20415.591688166154;1804.6300508395748;1887.2262372427376;1896.6775648139712;1937.4865660599953;2489.7634724701124;11877.406129693567;13101.951843852468;13193.340332983313;13223.669408264774;13632;1688.5694147992306;1775.1213149490954;1788.3472532525534;1803.071418219618;1847.3413464161918;66285.66857165731;67977.66011169912;69425.3057469424;69453;70843.29156708419;9370.250379969586;9406;9742.853857192147;9766.560504777302;9823.607055717834;11005.504752286166;12833.037522185874;12883.613491595268;12896.871031289567;12952.28762418076;5463.672179669233;5715.8571035724435;5719.19931209631;6073.939260607426;7185.748498802622;6948.5483443576;6951.582905025714;7046.471514636422;7155.177154627285;7193.388561972186;3710.424884142962;3728.850845966131;3919.060065267654;4043.6360727534075;4181.6236538711055;1782.7058535341782;1786.5355007698092;1790.7224380221087;1810.8732388732926;1828.4149072297002;789.6880732110784;813.8372325534798;833.7540425574471;871.011402058668;904.8056565333696;15507.689846203013;16883.91558042202;16960.321587136375;17028.829711702725;17212.397566085376;792.9841403171904;808.8746244332137;812.5124925045044;814.8085199978001;894.8076163624852;9041.864372034424;9198.586063627154;9688.515574221401;9700.805983880284;9770.316077874622;339100;340947;342558;349594;352713;50486.24270635944;58001;74900;75476;78496;919.2737737187547;949.368669834566;962.0331566775346;963.643451922779;966.1787480641399;15250;15295.923520382326;15334.386624534895;15906.443274485337;16213.837861621705;29053.983110591027;29744.553831692974;35003.47494787529;35088.47367289442;35739.28521429505;45896.770516147204;47029.529704702516;47234.76382618065;47413.76293118512;47737.76131119461;7543.924560754323;7548;7640.579768112807;7733.149353570991;7913.525188488709;8544.444611100258;11644.53421863116;11696.181267311547;11724.296542207494;12218.511259549874;9700.951495242478;10103.191744660557;10202;10448.843267350843;10657.733556660834;10040.246981476272;10064.094231519199;10097.949510252402;10166.8474972874;10328.535215915452;9706.805863882542;9939.254555908192;10181.74545636365;10298.536565854405;10989.450527473755;7513.248675132443;7636.694532218649;7640.235976402315;7662.923370766221;7752.806179845549;9704.223662107155;9786.85319720219;9914.553845076845;10305.433201174008;10522.421266830397 14:59:01 INFO - PROCESS | 15209 | |3;mootools.html;1302.2056545507241;1343.6227866436905;1416.192770121031;1651.694436529243;1676.2289346900418;6408.48732101432;6652.966735166329;6949.478789090819;7401.555906645598;7461.925380746191;7008.439324854012;7237.782866514;7238;7423.1092268927805;7427.851442971138;2096.748390193179;2131.8827464489445;2134.349023547817;2137.8289736821016;2144.0673307111456;1856.303886042734;1921.1546919355508;2104.8737075775425;2133.839962002848;2204.151401710345;1884.6324966631512;1905.0665174064677;1913.7607799025122;2041.9285325013627;2124.341454149219;2121.8939053047284;2125.95748085039;2130.4034870236205;2130.403487023636;2132.093860109447;2096.360610013945;2113.598416300898;2118.4809721618303;2161.384005558424;2165.2421652421685;7399.408047356253;7420.777376678654;7439.665215065335;7460.25397460255;7464.1416237132335;4285.678574106923;4412.338149277602;4413.713108647928;4415.955840441618;4416.2713152329825;2844.416894536636;2899.043315705812;2991.4017196560776;3033.0597514770493;3047.49716296813;851.6252848746532;887.8135591525787;895.6865097215988;914.2685851318985;914.9679761208392;9731.41611503305;9771.951140244324;9789.559469823804;9792.853107203398;9808.16630586401;4035.394690796404;4128.772917489507;4237.025484138665;4238.554951730086;4288.978555107205;8584.74245772628;8592.52741099233;8606.053334133241;8607.698730544525;8609.225169734755;4460.553944605514;4530.139273538017;4532.4334458192725;4541.3869127668;4609;4038.3336749436603;4154.148399578079;4155.605217504332;4157.8960525987095;4194.916101677949;3474.2530355973586;3488.5639295088113;3572.8749493767596;3680.926381472409;3682.8895133146048;1129.2434069173673;1139.3107170162098;1141.697450175704;1167.10716302029;1172.8475298211179;769.9884501732479;811.8877138320539;823.9052508961427;833.794904256996;835.715856608756;4852.417709874838;5008.248762685554;5098.413682426569;5114.846554603368;5185.455527169668;815.3029160068174;824.6536454688925;844.7043534762784;848.6902280667636;858.4763294390542;3380.3915295247093;3438.3639026779624;3459.152507635595;3481.912952176165;3556.7332450066347;8601.440906341068;8973;8997.730068097968;9004.36969412148;9005.14451127142;8231.629576669064;8648.43785153963;8915.509646969349;8941.284697224206;8948.194662480408;6754.425873800684;6879.965600171967;6927.93072069283;6928.237893831674;6932.861342773116;4970.676906001098;5107.540321371094;5111.744412779421;5161.432242453252;5229.346331708536;8070.112287648237;8132.593370331341;8231.42380033392;8256.83486330282;8335.208155225244;8276.172382761675;8310.21052999964;8373.62318695648;8490.448120872123;8542;6403.0715546246465;6453.935460645521;6489.221293444817;6505.284418714033;6517.217933847968;6868.313168683092;6978.720851166099;6982.720691172296;6993.930060699531;6998.650067496503;6369.8726025480155;6461.160049193575;6479.708413121327;6498.252700939453;6659.800205993828;6361.968190159205;6403.935960640334;6421.486281097407;6426.678666066585;6457.5479716419395;5976.193213916065;6073.696315184311;6077.088436734349;6078.270607527125;6081.756729730761;4292.570742925807;4454.28731402974;4473.798679059385;4558.703684260512;4560.794764235551;4359.956400435955;4418.911621767611;4487.147441986012;4557.384753058294;4621.60716339115 14:59:01 INFO - PROCESS | 15209 | |4;prototype.html;351.5605493133583;356.73423299641763;358.64852444604287;365.36244253777164;366.7157952586745;4831.830885918994;4876.366072410586;4892.828750993716;4904.498705660112;4922;4810.759462026894;4842.636802239828;4859.975700121503;4865.635077369194;4884.3406140171155;3530.7881527108457;3688.889333320005;3770.9811450942707;3796.2597293527774;3852.325842977468;3826.9043273918096;3831.5593706723803;3846.1538461538557;3848.3265428549894;3876.554196267437;3853.3064048471265;3857.517810273716;3862.5558060822946;3872.1674839909556;3874.9850077959445;3702.981485092584;3755.868544600953;3802.3535998880257;3883.5533913599875;3890.4164375343644;3496.230829217568;3498.160441494023;3506.281212351462;3527.488514165457;3533.561842328785;4737;4741.762911854428;4746.477887432379;4746.596539294164;4750.738709370983;4350.673699472521;4408.823647054146;4460.33095035744;4464.196444639963;4466.464024317071;5071.3407257056715;5080.390353157608;5090.567301779353;5112.718800465973;5114.667546609458;3818.369968955119;3825.7895815730126;3830.731848770587;3840.135969406889;3856.3251430999744;5097.388313402378;5151.356080489976;5155.407128180233;5359.276497672842;5392.487713667235;3859.498265225559;3875.922481550353;3909.980450097731;3922.8234729437245;3925.8822235332987;3948.466956960831;3962.40563915415;3964.5440774311323;3965.5836137205756;3966.4446977423186;4250.277452833026;4391.209582275157;4400.163968845909;4417.867463976086;4418.541881179203;5035.2124995626755;5051.494850514919;5051.494850514919;5053.9494605054215;5055.494450554988;1340.766494824744;1343.9731205376033;1349.3672656086048;1353.911995720275;1358.1918758338772;919.5027589876825;958.4393130019017;959.6257459590765;961.9326647134774;968.3124981263381;4358.302671572596;4370.847020354272;4378.43080399546;4386.8025938832825;4437.64498840092;5152.407473140562;5158.896822063538;5173.81891633791;5179.05785330501;5191.247269146028;4301.612854843079;4419.403380543586;4449.688521803508;4450.844220452269;4460.420145381145;2738.1785464360614;2743.4238809850153;2745.217612980331;2748.931276718098;2750.9958865014128;4677.690246730921;4720.173969555382;4735.502772208868;4736.668433209642;4739.95260047402;4934.481879402683;5177.265616018601;5206.76569554371;5213.530782229617;5231.8168864089575;4711.552402521755;4725.432948046257;4730.243161094278;4732.556570246039;4736.739479328532;5105.693658380509;5117.21326218603;5119.206522988943;5138.3063286457345;5154.845354639367;4886.413630364379;4989.176785830297;5002.399712034579;5028.698278103326;5156.381234251764;4688.9296660549435;4788.353572267699;4809.44691360498;4905.828296009622;4906.2640603909695;3699.574548926908;3705.888823335304;3706.4810926470855;3708.2027364116843;3711.721620878499;5275.657082289639;5282.019242783956;5304.310439642976;5305.973470132624;5308.787648494017;4958.041573578488;5023;5060.21566657154;5105.081085404663;5116.667416617908;5051.564935843515;5066.544011039025;5067.467915868928;5074.517920797518;5099.36257967754;5013.849584512471;5060.924086138784;5065.848024559269;5070.6957582545165;5073.746312684425;5022.573081287986;5093.23601459784;5116.462771408948;5124.615653825904;5143.177091665316;4941.728204948762;4951.653384263067;4988.9501104988485;4990.15167421532;4998.925016124688 14:59:01 INFO - PROCESS | 15209 | |5;yui.html;621.2638023941629;652.8335274505002;671.6071098407432;710.357126800246;742.0353540397482;12439.813402798954;13604.727905441885;13635.045546811727;13667.453301867925;13693.65765855854;12898.226106433596;13074.673133171651;13095.607131786039;13132.474701011972;14399.136051836897;614.8739508400768;642.3640595810161;758.5638258001644;778.879273712574;791.7703865878888;793.2424534569473;798.1180795221284;798.4410912361341;798.4889670610813;798.664560884427;832.4921797703396;833.687367237286;833.795720048586;834.1825011488745;834.4617721569584;643.7521554201619;671.9294474080225;793.4604468961104;827.4745536584252;832.0223737108934;610.7618028968706;612.623236709425;613.2732711736606;614.213806327901;615.575253075381;12996.155249908727;13108.541201058013;13116.86883131166;13165.868341316656;13174.143680660727;12025.398730063462;12082.002024251338;12311.322877241748;12358.258504489759;12423.378831058411;11581.18931674783;11685;11716.941415292955;11907.880921190765;12055.276683399024;3947.960520394788;4034.616711412411;4066.6340029397497;4229.027323715532;4235.9364609530885;44570.33144502835;58770.70614646899;59155.70422147862;59482.70258648679;60094;9737.707868763806;9844.950775246221;9901.900980990242;9983.400995940267;10058.748531286776;17160.914195428944;17807.821921780876;17865.374711885022;18064.638707226044;18079;6849.075374824335;6978.302169782981;7047;7119.21688614252;7309.488335816442;3720.776753394805;3733.9813300933865;3744.7940363279736;3767.585565587783;3788.242351529705;2857.7570906473184;2918.7810914181523;2935.530315149566;2940.147357266369;2947.189522881225;473.8673171511982;475.6480204648535;476.0289010418707;481.5978657820689;489.23434824499543;552.6269767906647;583.1486030395586;587.5563949218313;591.9171316015761;594.3699678340972;8233.958830205811;8547.487150770974;8600.78498037554;8799.208071273617;8844.690435834844;594.6045879490177;627.8555932135635;639.0892977507034;640.6444423344996;642.5855323316434;4002.679785617144;4245.320748680197;4260.573942605776;4272.807723652443;4309.41822853917;66469.6676516624;66746;66988;68848.6557567209;69006.30993690099;46267.30599041017;51102.488975110515;57829.71085144632;58937;60264.698676507214;53045.204321935205;53451;53681.19478207908;53794.7310263454;54395.45604543983;7808.180141085104;8423.70517031901;8450.915490845258;8454;8594.613242403982;36378.636213637525;36880.26239475249;38410.6158938407;38779.80610097044;39419.2116157681;45155.322670159316;48677.513224868715;49645.503544964085;49773;51105;9410.153086222273;9704.417734935927;9880.752981175528;9942.652007179713;10047.598096076075;10950.671479855617;10953.507092181031;11122.610708625483;11324.037456816262;11475.885241147482;9674.177694896012;10305.278630495794;11521.078313735048;12134.26333040245;12343.13598048128;11471.311721296748;11793.52091133135;11816.468258928197;12285.38573071325;12290.692732681755;11873.008614219301;12233.388330583613;12267.815982760087;12280.140390172603;12603.495860165858;9905.533063427743;9975.551100200653;10322.845157322796;10327.32872363294;10387.169026477712;8612.569371531274;9692.418454892448;9927.305088643725;9991.100800927952;10147.391156530632 14:59:01 INFO - PROCESS | 15209 | __end_tp_report 14:59:01 INFO - PROCESS | 15209 | __start_cc_report 14:59:01 INFO - PROCESS | 15209 | _x_x_mozilla_cycle_collect,1732 14:59:01 INFO - PROCESS | 15209 | __end_cc_report 14:59:01 INFO - PROCESS | 15209 | __startTimestamp1482361141909__endTimestamp 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | ------- Summary: start ------- 14:59:01 INFO - PROCESS | 15209 | Number of tests: 6 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#0] dojo.html Cycles:165 Average:4752.22 Median:4866.25 stddev:496.84 (10.2%) stddev-sans-first:469.18 14:59:01 INFO - PROCESS | 15209 | Values: 2613.2 2618.6 2656.9 2674.2 2683.1 4667.4 4735.2 4754.5 4840.4 4866.2 4747.3 4821.2 4854.6 4892.5 4920.4 4387.8 4403.8 4408.0 4431.8 4482.5 4449.0 4489.8 4507.3 4528.1 4558.3 4436.0 4478.9 4479.8 4493.8 4515.8 4272.2 4304.9 4310.8 4362.1 4362.2 4387.7 4389.5 4449.2 4449.9 4465.1 4751.2 4781.7 4810.1 4812.4 4868.2 5018.0 5062.5 5064.3 5186.6 5196.4 5095.4 5170.0 5177.6 5215.8 5262.8 4839.1 4840.5 4850.1 4852.6 4898.5 5198.8 5313.5 5323.6 5325.3 5325.5 5006.9 5052.5 5080.9 5094.0 5097.2 5189.4 5197.3 5197.9 5200.4 5238.8 5107.5 5137.9 5157.6 5160.0 5205.7 4945.9 4962.4 4965.4 5020.7 5116.6 4385.5 4406.0 4408.2 4411.9 4417.0 3841.4 3845.9 3869.8 3873.8 3887.1 4417.6 4419.1 4419.1 4423.0 4457.1 4946.3 4947.0 4953.1 5170.3 5209.0 4386.9 4421.1 4423.3 4432.6 4471.8 4680.6 4694.5 4694.7 4696.6 4700.3 4596.7 4789.6 4799.8 4800.8 4805.8 4994.9 5076.5 5139.3 5206.8 5212.9 4819.3 4830.3 4830.9 4841.4 4884.7 5137.9 5141.6 5141.9 5145.0 5145.3 5013.5 5048.2 5053.3 5118.4 5124.8 4983.6 4986.1 5030.0 5053.8 5104.7 5033.3 5042.6 5045.5 5046.9 5050.2 4752.5 4965.1 4968.2 4974.9 4977.4 4879.0 5010.3 5037.7 5048.3 5122.6 4803.3 4838.2 4921.1 4928.6 4975.7 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#1] ext.html Cycles:180 Average:42643.87 Median:3453.74 stddev:72651.00 (2103.5%) stddev-sans-first:72785.98 14:59:01 INFO - PROCESS | 15209 | Values: 524.4 544.7 555.7 561.1 569.7 27907.6 36359.0 37867.4 37897.6 41672.0 39478.2 39960.0 40046.4 40077.2 40097.0 7206.1 7514.3 7737.5 7748.4 7754.8 7214.5 9619.3 9868.9 9880.5 10179.1 9395.2 9436.4 9441.9 9445.0 9447.3 9692.0 9739.2 9745.4 9760.1 9761.6 9689.9 9748.6 9748.7 9758.2 9766.8 37685.2 37965.6 38009.2 38060.0 38067.0 2908.0 2910.0 3061.4 3218.0 3507.6 26202.2 26698.5 26746.3 26772.7 26813.2 3344.8 3444.6 3462.9 3480.9 3511.8 241829.0 241955.0 243107.0 243276.8 243545.0 51657.5 51827.5 52021.0 52133.5 52186.7 54978.0 55041.4 55135.4 55357.0 55414.4 13798.4 14001.3 14028.1 14038.4 14099.9 9613.4 9841.0 10478.5 10755.4 10904.6 15596.2 16313.4 16340.2 16473.5 16491.2 5751.3 5789.2 5794.9 5911.4 6014.3 703.3 772.6 846.5 952.5 976.2 25870.6 26877.2 26888.9 27319.9 27347.6 893.9 935.2 964.7 973.4 1000.2 13940.9 14285.9 14500.3 14576.2 14769.0 310813.0 311498.0 313879.0 314157.0 316410.0 45222.5 45365.6 45419.8 45438.5 45500.8 1030.4 1052.7 1089.0 1094.1 1146.3 26145.6 27339.6 27705.5 27944.9 28321.4 40032.8 40579.8 40632.0 40661.6 40679.6 270889.0 271976.0 272479.0 272656.0 272821.0 21855.3 22673.4 22715.7 23783.4 24060.5 34636.0 34737.8 35137.6 35368.8 35790.8 29964.9 30329.0 30518.2 30555.0 30935.4 30066.2 30175.2 30539.5 31062.7 31588.5 30138.7 30198.5 30366.0 33781.3 34766.1 26760.3 27950.0 28563.0 28994.7 29028.0 21587.4 22044.7 22149.0 22591.3 24320.8 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#2] jquery.html Cycles:180 Average:22485.06 Median:46463.15 stddev:57027.81 (122.7%) stddev-sans-first:57163.54 14:59:01 INFO - PROCESS | 15209 | Values: 339.5 367.4 369.4 372.6 388.5 12343.3 15710.5 15917.9 17168.7 17340.4 14907.7 15069.2 16725.9 16826.2 16993.2 4771.9 4850.0 4978.1 5004.9 5016.2 3639.4 3814.0 4967.7 5066.4 5068.5 5600.6 5856.4 5868.6 5968.6 5977.5 5780.5 5924.9 5954.3 5966.1 5981.5 5271.6 5272.8 5278.5 5280.3 5280.7 20087.5 20230.9 20384.8 20385.5 20415.6 1804.6 1887.2 1896.7 1937.5 2489.8 11877.4 13102.0 13193.3 13223.7 13632.0 1688.6 1775.1 1788.3 1803.1 1847.3 66285.7 67977.7 69425.3 69453.0 70843.3 9370.3 9406.0 9742.9 9766.6 9823.6 11005.5 12833.0 12883.6 12896.9 12952.3 5463.7 5715.9 5719.2 6073.9 7185.7 6948.5 6951.6 7046.5 7155.2 7193.4 3710.4 3728.9 3919.1 4043.6 4181.6 1782.7 1786.5 1790.7 1810.9 1828.4 789.7 813.8 833.8 871.0 904.8 15507.7 16883.9 16960.3 17028.8 17212.4 793.0 808.9 812.5 814.8 894.8 9041.9 9198.6 9688.5 9700.8 9770.3 339100.0 340947.0 342558.0 349594.0 352713.0 50486.2 58001.0 74900.0 75476.0 78496.0 919.3 949.4 962.0 963.6 966.2 15250.0 15295.9 15334.4 15906.4 16213.8 29054.0 29744.6 35003.5 35088.5 35739.3 45896.8 47029.5 47234.8 47413.8 47737.8 7543.9 7548.0 7640.6 7733.1 7913.5 8544.4 11644.5 11696.2 11724.3 12218.5 9701.0 10103.2 10202.0 10448.8 10657.7 10040.2 10064.1 10097.9 10166.8 10328.5 9706.8 9939.3 10181.7 10298.5 10989.5 7513.2 7636.7 7640.2 7662.9 7752.8 9704.2 9786.9 9914.6 10305.4 10522.4 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#3] mootools.html Cycles:180 Average:4876.79 Median:6024.94 stddev:2639.26 (43.8%) stddev-sans-first:2632.99 14:59:01 INFO - PROCESS | 15209 | Values: 1302.2 1343.6 1416.2 1651.7 1676.2 6408.5 6653.0 6949.5 7401.6 7461.9 7008.4 7237.8 7238.0 7423.1 7427.9 2096.7 2131.9 2134.3 2137.8 2144.1 1856.3 1921.2 2104.9 2133.8 2204.2 1884.6 1905.1 1913.8 2041.9 2124.3 2121.9 2126.0 2130.4 2130.4 2132.1 2096.4 2113.6 2118.5 2161.4 2165.2 7399.4 7420.8 7439.7 7460.3 7464.1 4285.7 4412.3 4413.7 4416.0 4416.3 2844.4 2899.0 2991.4 3033.1 3047.5 851.6 887.8 895.7 914.3 915.0 9731.4 9772.0 9789.6 9792.9 9808.2 4035.4 4128.8 4237.0 4238.6 4289.0 8584.7 8592.5 8606.1 8607.7 8609.2 4460.6 4530.1 4532.4 4541.4 4609.0 4038.3 4154.1 4155.6 4157.9 4194.9 3474.3 3488.6 3572.9 3680.9 3682.9 1129.2 1139.3 1141.7 1167.1 1172.8 770.0 811.9 823.9 833.8 835.7 4852.4 5008.2 5098.4 5114.8 5185.5 815.3 824.7 844.7 848.7 858.5 3380.4 3438.4 3459.2 3481.9 3556.7 8601.4 8973.0 8997.7 9004.4 9005.1 8231.6 8648.4 8915.5 8941.3 8948.2 6754.4 6880.0 6927.9 6928.2 6932.9 4970.7 5107.5 5111.7 5161.4 5229.3 8070.1 8132.6 8231.4 8256.8 8335.2 8276.2 8310.2 8373.6 8490.4 8542.0 6403.1 6453.9 6489.2 6505.3 6517.2 6868.3 6978.7 6982.7 6993.9 6998.7 6369.9 6461.2 6479.7 6498.3 6659.8 6362.0 6403.9 6421.5 6426.7 6457.5 5976.2 6073.7 6077.1 6078.3 6081.8 4292.6 4454.3 4473.8 4558.7 4560.8 4360.0 4418.9 4487.1 4557.4 4621.6 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#4] prototype.html Cycles:180 Average:4230.99 Median:4738.48 stddev:1184.94 (25.0%) stddev-sans-first:1151.94 14:59:01 INFO - PROCESS | 15209 | Values: 351.6 356.7 358.6 365.4 366.7 4831.8 4876.4 4892.8 4904.5 4922.0 4810.8 4842.6 4860.0 4865.6 4884.3 3530.8 3688.9 3771.0 3796.3 3852.3 3826.9 3831.6 3846.2 3848.3 3876.6 3853.3 3857.5 3862.6 3872.2 3875.0 3703.0 3755.9 3802.4 3883.6 3890.4 3496.2 3498.2 3506.3 3527.5 3533.6 4737.0 4741.8 4746.5 4746.6 4750.7 4350.7 4408.8 4460.3 4464.2 4466.5 5071.3 5080.4 5090.6 5112.7 5114.7 3818.4 3825.8 3830.7 3840.1 3856.3 5097.4 5151.4 5155.4 5359.3 5392.5 3859.5 3875.9 3910.0 3922.8 3925.9 3948.5 3962.4 3964.5 3965.6 3966.4 4250.3 4391.2 4400.2 4417.9 4418.5 5035.2 5051.5 5051.5 5053.9 5055.5 1340.8 1344.0 1349.4 1353.9 1358.2 919.5 958.4 959.6 961.9 968.3 4358.3 4370.8 4378.4 4386.8 4437.6 5152.4 5158.9 5173.8 5179.1 5191.2 4301.6 4419.4 4449.7 4450.8 4460.4 2738.2 2743.4 2745.2 2748.9 2751.0 4677.7 4720.2 4735.5 4736.7 4740.0 4934.5 5177.3 5206.8 5213.5 5231.8 4711.6 4725.4 4730.2 4732.6 4736.7 5105.7 5117.2 5119.2 5138.3 5154.8 4886.4 4989.2 5002.4 5028.7 5156.4 4688.9 4788.4 4809.4 4905.8 4906.3 3699.6 3705.9 3706.5 3708.2 3711.7 5275.7 5282.0 5304.3 5306.0 5308.8 4958.0 5023.0 5060.2 5105.1 5116.7 5051.6 5066.5 5067.5 5074.5 5099.4 5013.8 5060.9 5065.8 5070.7 5073.7 5022.6 5093.2 5116.5 5124.6 5143.2 4941.7 4951.7 4989.0 4990.2 4998.9 14:59:01 INFO - PROCESS | 15209 | 14:59:01 INFO - PROCESS | 15209 | [#5] yui.html Cycles:180 Average:14785.67 Median:50437.74 stddev:18311.00 (36.3%) stddev-sans-first:18331.48 14:59:01 INFO - PROCESS | 15209 | Values: 621.3 652.8 671.6 710.4 742.0 12439.8 13604.7 13635.0 13667.5 13693.7 12898.2 13074.7 13095.6 13132.5 14399.1 614.9 642.4 758.6 778.9 791.8 793.2 798.1 798.4 798.5 798.7 832.5 833.7 833.8 834.2 834.5 643.8 671.9 793.5 827.5 832.0 610.8 612.6 613.3 614.2 615.6 12996.2 13108.5 13116.9 13165.9 13174.1 12025.4 12082.0 12311.3 12358.3 12423.4 11581.2 11685.0 11716.9 11907.9 12055.3 3948.0 4034.6 4066.6 4229.0 4235.9 44570.3 58770.7 59155.7 59482.7 60094.0 9737.7 9845.0 9901.9 9983.4 10058.7 17160.9 17807.8 17865.4 18064.6 18079.0 6849.1 6978.3 7047.0 7119.2 7309.5 3720.8 3734.0 3744.8 3767.6 3788.2 2857.8 2918.8 2935.5 2940.1 2947.2 473.9 475.6 476.0 481.6 489.2 552.6 583.1 587.6 591.9 594.4 8234.0 8547.5 8600.8 8799.2 8844.7 594.6 627.9 639.1 640.6 642.6 4002.7 4245.3 4260.6 4272.8 4309.4 66469.7 66746.0 66988.0 68848.7 69006.3 46267.3 51102.5 57829.7 58937.0 60264.7 53045.2 53451.0 53681.2 53794.7 54395.5 7808.2 8423.7 8450.9 8454.0 8594.6 36378.6 36880.3 38410.6 38779.8 39419.2 45155.3 48677.5 49645.5 49773.0 51105.0 9410.2 9704.4 9880.8 9942.7 10047.6 10950.7 10953.5 11122.6 11324.0 11475.9 9674.2 10305.3 11521.1 12134.3 12343.1 11471.3 11793.5 11816.5 12285.4 12290.7 11873.0 12233.4 12267.8 12280.1 12603.5 9905.5 9975.6 10322.8 10327.3 10387.2 8612.6 9692.4 9927.3 9991.1 10147.4 14:59:01 INFO - PROCESS | 15209 | -------- Summary: end -------- 14:59:01 INFO - PROCESS | 15209 | 14:59:02 INFO - TEST-INFO | 15209: exit 0 14:59:02 INFO - TEST-OK | dromaeo_css | took 1122796ms 14:59:02 INFO - TEST-START | kraken 14:59:02 INFO - operating with platform_type : linux_ 14:59:02 INFO - Initialising browser for kraken test... 14:59:02 INFO - TEST-INFO | started process 15507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBZ7_H/profile http://localhost:33029/getInfo.html) 14:59:06 INFO - PROCESS | 15507 | __metrics Screen width/height:1600/1200 14:59:06 INFO - PROCESS | 15507 | colorDepth:24 14:59:06 INFO - PROCESS | 15507 | Browser inner width/height: 1024/697 14:59:06 INFO - PROCESS | 15507 | __metrics 14:59:07 INFO - PROCESS | 15507 | 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" 14:59:07 INFO - PROCESS | 15507 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:08 INFO - PROCESS | 15507 | console.error: PushService: 14:59:08 INFO - PROCESS | 15507 | stateChangeProcessEnqueue: Error transitioning state 14:59:08 INFO - PROCESS | 15507 | UnknownError 14:59:08 INFO - TEST-INFO | 15507: exit 0 14:59:08 INFO - Browser initialized. 14:59:08 INFO - Running cycle 1/1 for kraken test... 14:59:08 INFO - TEST-INFO | started process 15590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBZ7_H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:20 INFO - PROCESS | 15590 | RSS: Main: 155643904 14:59:20 INFO - PROCESS | 15590 | 14:59:23 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33029/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:24 INFO - PROCESS | 15590 | RSS: Main: 208785408 14:59:24 INFO - PROCESS | 15590 | 14:59:27 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33029/tests/kraken/driver.html?testName=audio-dft) 14:59:27 INFO - PROCESS | 15590 | RSS: Main: 187482112 14:59:27 INFO - PROCESS | 15590 | 14:59:30 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33029/tests/kraken/driver.html?testName=audio-fft) 14:59:31 INFO - PROCESS | 15590 | RSS: Main: 269631488 14:59:31 INFO - PROCESS | 15590 | 14:59:33 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33029/tests/kraken/driver.html?testName=audio-oscillator) 14:59:34 INFO - PROCESS | 15590 | RSS: Main: 181219328 14:59:34 INFO - PROCESS | 15590 | 14:59:36 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33029/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:37 INFO - PROCESS | 15590 | RSS: Main: 184057856 14:59:37 INFO - PROCESS | 15590 | 14:59:40 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33029/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:41 INFO - PROCESS | 15590 | RSS: Main: 223793152 14:59:41 INFO - PROCESS | 15590 | 14:59:44 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33029/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:45 INFO - PROCESS | 15590 | RSS: Main: 218095616 14:59:45 INFO - PROCESS | 15590 | 14:59:47 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33029/tests/kraken/driver.html?testName=json-parse-financial) 14:59:48 INFO - PROCESS | 15590 | RSS: Main: 220241920 14:59:48 INFO - PROCESS | 15590 | 14:59:50 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33029/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:50 INFO - PROCESS | 15590 | RSS: Main: 182910976 14:59:50 INFO - PROCESS | 15590 | 14:59:52 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:53 INFO - PROCESS | 15590 | RSS: Main: 190210048 14:59:53 INFO - PROCESS | 15590 | 14:59:55 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:56 INFO - PROCESS | 15590 | RSS: Main: 198664192 14:59:56 INFO - PROCESS | 15590 | 14:59:59 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:59 INFO - PROCESS | 15590 | RSS: Main: 209305600 14:59:59 INFO - PROCESS | 15590 | 15:00:02 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:03 INFO - PROCESS | 15590 | RSS: Main: 204562432 15:00:03 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | Cycle 1(1): loaded http://localhost:33029/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33029/tests/kraken/driver.html?testName=ai-astar) 15:00:05 INFO - PROCESS | 15590 | RSS: Main: 255148032 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | __start_tp_report 15:00:05 INFO - PROCESS | 15590 | _x_x_mozilla_page_load 15:00:05 INFO - PROCESS | 15590 | _x_x_mozilla_page_load_details 15:00:05 INFO - PROCESS | 15590 | |i|pagename|runs| 15:00:05 INFO - PROCESS | 15590 | |0;ai-astar;106;117;116;115;115;115;115;115;114;116 15:00:05 INFO - PROCESS | 15590 | |1;audio-beat-detection;152;131;129;170;134;125;132;131;153;131 15:00:05 INFO - PROCESS | 15590 | |2;audio-dft;161;161;160;162;162;161;165;163;162;162 15:00:05 INFO - PROCESS | 15590 | |3;audio-fft;76;76;76;107;78;77;76;77;96;77 15:00:05 INFO - PROCESS | 15590 | |4;audio-oscillator;85;86;107;85;84;86;99;85;86;114 15:00:05 INFO - PROCESS | 15590 | |5;imaging-gaussian-blur;127;127;127;127;127;128;128;127;128;127 15:00:05 INFO - PROCESS | 15590 | |6;imaging-darkroom;148;148;147;147;146;147;147;147;147;146 15:00:05 INFO - PROCESS | 15590 | |7;imaging-desaturate;95;96;95;95;96;95;96;96;95;95 15:00:05 INFO - PROCESS | 15590 | |8;json-parse-financial;64;64;63;63;64;69;65;64;64;64 15:00:05 INFO - PROCESS | 15590 | |9;json-stringify-tinderbox;67;67;66;66;65;66;65;69;65;67 15:00:05 INFO - PROCESS | 15590 | |10;stanford-crypto-aes;84;84;84;85;85;84;88;86;86;85 15:00:05 INFO - PROCESS | 15590 | |11;stanford-crypto-ccm;148;136;139;137;133;137;137;133;178;137 15:00:05 INFO - PROCESS | 15590 | |12;stanford-crypto-pbkdf2;179;182;179;179;176;177;181;179;179;174 15:00:05 INFO - PROCESS | 15590 | |13;stanford-crypto-sha256-iterative;70;69;71;70;69;69;70;68;69;73 15:00:05 INFO - PROCESS | 15590 | __end_tp_report 15:00:05 INFO - PROCESS | 15590 | __start_cc_report 15:00:05 INFO - PROCESS | 15590 | _x_x_mozilla_cycle_collect,1927 15:00:05 INFO - PROCESS | 15590 | __end_cc_report 15:00:05 INFO - PROCESS | 15590 | __startTimestamp1482361205531__endTimestamp 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | ------- Summary: start ------- 15:00:05 INFO - PROCESS | 15590 | Number of tests: 14 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 15:00:05 INFO - PROCESS | 15590 | Values: 106.0 117.0 116.0 115.0 115.0 115.0 115.0 115.0 114.0 116.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:133.00 stddev:14.48 (10.9%) stddev-sans-first:14.55 15:00:05 INFO - PROCESS | 15590 | Values: 152.0 131.0 129.0 170.0 134.0 125.0 132.0 131.0 153.0 131.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 15:00:05 INFO - PROCESS | 15590 | Values: 161.0 161.0 160.0 162.0 162.0 161.0 165.0 163.0 162.0 162.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#3] audio-fft Cycles:10 Average:81.60 Median:77.00 stddev:10.82 (14.1%) stddev-sans-first:11.29 15:00:05 INFO - PROCESS | 15590 | Values: 76.0 76.0 76.0 107.0 78.0 77.0 76.0 77.0 96.0 77.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.50 stddev:10.93 (12.8%) stddev-sans-first:11.33 15:00:05 INFO - PROCESS | 15590 | Values: 85.0 86.0 107.0 85.0 84.0 86.0 99.0 85.0 86.0 114.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#5] imaging-gaussian-blur Cycles:10 Average:127.30 Median:127.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:00:05 INFO - PROCESS | 15590 | Values: 127.0 127.0 127.0 127.0 127.0 128.0 128.0 127.0 128.0 127.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 15:00:05 INFO - PROCESS | 15590 | Values: 148.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:00:05 INFO - PROCESS | 15590 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:1.71 (2.7%) stddev-sans-first:1.81 15:00:05 INFO - PROCESS | 15590 | Values: 64.0 64.0 63.0 63.0 64.0 69.0 65.0 64.0 64.0 64.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 15:00:05 INFO - PROCESS | 15590 | Values: 67.0 67.0 66.0 66.0 65.0 66.0 65.0 69.0 65.0 67.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 15:00:05 INFO - PROCESS | 15590 | Values: 84.0 84.0 84.0 85.0 85.0 84.0 88.0 86.0 86.0 85.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:137.00 stddev:13.48 (9.8%) stddev-sans-first:14.10 15:00:05 INFO - PROCESS | 15590 | Values: 148.0 136.0 139.0 137.0 133.0 137.0 137.0 133.0 178.0 137.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:179.00 stddev:2.32 (1.3%) stddev-sans-first:2.46 15:00:05 INFO - PROCESS | 15590 | Values: 179.0 182.0 179.0 179.0 176.0 177.0 181.0 179.0 179.0 174.0 15:00:05 INFO - PROCESS | 15590 | 15:00:05 INFO - PROCESS | 15590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 15:00:05 INFO - PROCESS | 15590 | Values: 70.0 69.0 71.0 70.0 69.0 69.0 70.0 68.0 69.0 73.0 15:00:05 INFO - PROCESS | 15590 | -------- Summary: end -------- 15:00:05 INFO - PROCESS | 15590 | 15:00:06 INFO - TEST-INFO | 15590: exit 0 15:00:06 INFO - TEST-OK | kraken | took 64023ms 15:00:06 INFO - SUITE-END | took 1186s 15:00:07 INFO - Completed test suite (00:19:47) 15:00:07 INFO - javascript benchmark 15:00:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2613.216035189443, 2618.633391325214, 2656.880440380183, 2674.184373766002, 2683.0609286749627, 4667.39323887895, 4735.171345014626, 4754.453237877645, 4840.44334901486, 4866.24573191155, 4747.28790681398, 4821.180399332113, 4854.56308932196, 4892.486288939664, 4920.409550853902, 4387.758673272969, 4403.801828917691, 4408.030233348674, 4431.778411079449, 4482.529334419888, 4448.998975230579, 4489.775511224442, 4507.2788353863225, 4528.094381123772, 4558.27067669173, 4435.955640443619, 4478.910421791578, 4479.843205487792, 4493.775311234425, 4515.819367225307, 4272.166927449118, 4304.935425968613, 4310.78446077698, 4362.1275744851155, 4362.192994296065, 4387.714798538085, 4389.5390983946545, 4449.243628583149, 4449.933251001237, 4465.084657645208, 4751.239801631722, 4781.737004464753, 4810.11012962603, 4812.389512735616, 4868.196747536652, 5017.974910125463, 5062.493750624945, 5064.3163172971545, 5186.5850731941355, 5196.428392876781, 5095.388553373619, 5170.017696637627, 5177.559907407875, 5215.843524694265, 5262.7631756571045, 4839.080574690797, 4840.540148685869, 4850.102730994707, 4852.636052296092, 4898.461169271377, 5198.792048318101, 5313.521783039545, 5323.600729945269, 5325.307709997753, 5325.547328477122, 5006.89986200274, 5052.520010598987, 5080.949190508048, 5094.0, 5097.184450487978, 5189.429162792166, 5197.272381866542, 5197.896042079137, 5200.427952925175, 5238.790448382022, 5107.489251074863, 5137.897242055138, 5157.561607263425, 5160.045391602565, 5205.713685747244, 4945.876353091129, 4962.429320628102, 4965.4041515018425, 5020.673656212408, 5116.641835071509, 4385.473743150842, 4405.977970110129, 4408.184485870124, 4411.911761764747, 4417.0, 3841.4237864320016, 3845.9230815383535, 3869.806509674505, 3873.845046198177, 3887.1448281378052, 4417.602415782595, 4419.0719948810465, 4419.11617676466, 4423.0, 4457.130859482435, 4946.258061290763, 4947.0, 4953.108440480676, 5170.302009228782, 5209.0363282792805, 4386.912261754747, 4421.115776844644, 4423.336499525097, 4432.645388368923, 4471.7987690554, 4680.625549955996, 4694.50707675696, 4694.694844835075, 4696.577308042224, 4700.341952126705, 4596.678232523691, 4789.640776941674, 4799.832005879777, 4800.807967681254, 4805.8077676892535, 4994.900101998012, 5076.517730815566, 5139.331886854835, 5206.791728330824, 5212.921806172986, 4819.2530157825595, 4830.347903033045, 4830.855074347775, 4841.394825646794, 4884.7069175849565, 5137.8972420550635, 5141.5629671476845, 5141.948580514147, 5145.022445735298, 5145.279660847559, 5013.523715247045, 5048.167052436307, 5053.343065401475, 5118.38579370478, 5124.820631278037, 4983.626228032839, 4986.102501549756, 5030.0, 5053.84838454847, 5104.719240441811, 5033.270175824412, 5042.647014709082, 5045.5459008689395, 5046.873828154326, 5050.242463630338, 4752.500987396412, 4965.081459929925, 4968.155413579628, 4974.925376119433, 4977.377827771528, 4879.04858552593, 5010.273510341053, 5037.722925239147, 5048.343715316985, 5122.641415101056, 4803.303520989507, 4838.153323168502, 4921.064997650435, 4928.6057115431395, 4975.676581022367], "value": 4720.275449568778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [524.4100387064552, 544.6976927805069, 555.6666000399758, 561.0882316236115, 569.7436153730822, 27907.581386279224, 36359.0, 37867.43198852019, 37897.621023789754, 41672.0, 39478.21043579127, 39960.0, 40046.39930401046, 40077.198456030936, 40097.0, 7206.063211782487, 7514.323710866035, 7737.458377913548, 7748.41886858485, 7754.8449031019345, 7214.458915581326, 9619.326647134669, 9868.851967220497, 9880.505974701236, 10179.083882450577, 9395.201407880339, 9436.433813971149, 9441.858372124423, 9444.952775236114, 9447.338686291961, 9692.0, 9739.220862330996, 9745.415275083518, 9760.07279308468, 9761.560729767178, 9689.90310096897, 9748.561314740853, 9748.658796942143, 9758.219342452587, 9766.755831104208, 37685.24629507394, 37965.62034379649, 38009.239815203815, 38060.0, 38067.04832379185, 2908.0, 2909.9854500727574, 3061.3877224555176, 3217.9678203218136, 3507.6141624421293, 26202.213933582025, 26698.466030679472, 26746.331341716417, 26772.732272677218, 26813.195604131906, 3344.823818086074, 3444.5866496020385, 3462.8961131166106, 3480.9303813923834, 3511.7717348372275, 241829.0, 241955.0, 243107.0, 243276.78361608257, 243545.0, 51657.48342516602, 51827.48172518227, 52021.0, 52133.478665213624, 52186.73906630443, 54978.0, 55041.44958550363, 55135.44864551383, 55357.0, 55414.44585554174, 13798.379072941741, 14001.299935003413, 14028.08817426864, 14038.36827342772, 14099.859001409855, 9613.423194608205, 9840.95079524612, 10478.476076196159, 10755.354678719303, 10904.61833835812, 15596.220188990505, 16313.42902998413, 16340.18299085041, 16473.505794826175, 16491.17544122813, 5751.309842818889, 5789.189513468118, 5794.913076303858, 5911.438413350725, 6014.278286605635, 703.2896774258036, 772.6252767407802, 846.5217152308926, 952.5332587032443, 976.2434113562047, 25870.6119408209, 26877.193684189504, 26888.865555672095, 27319.863400683265, 27347.589786153225, 893.8569828827357, 935.2284365398573, 964.6961207219704, 973.3721749471551, 1000.1946486591771, 13940.930295348458, 14285.857141428452, 14500.274986250644, 14576.198309093103, 14769.0, 310813.0, 311498.0, 313879.0, 314157.0, 316410.0, 45222.54777452249, 45365.63903082913, 45419.77290113594, 45438.54561454409, 45500.77249613731, 1030.443560477334, 1052.6841947415899, 1088.9727756805985, 1094.1137678480457, 1146.306484576819, 26145.607815882395, 27339.589906151024, 27705.53691275171, 27944.860275699306, 28321.433571328045, 40032.79983600063, 40579.79710101431, 40632.0, 40661.59338406578, 40679.59320406876, 270889.0, 271976.0, 272479.0, 272656.0, 272821.0, 21855.3443396692, 22673.39255985517, 22715.659265110706, 23783.405414864075, 24060.51878962376, 34636.0, 34737.82631086828, 35137.648623513436, 35368.823155884056, 35790.821045894605, 29964.850175748983, 30329.0, 30518.237044074074, 30555.0, 30935.381292374477, 30066.24834379158, 30175.245618859703, 30539.54190687186, 31062.68937310598, 31588.526172106976, 30138.69861301359, 30198.547021794253, 30366.0, 33781.324373512885, 34766.13084672904, 26760.33099172536, 27950.02174923868, 28563.0, 28994.7100528992, 29028.0, 21587.352379428015, 22044.669329959743, 22149.0, 22591.322260332217, 24320.75679243185], "value": 16763.29027960657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.54673995300124, 367.4488267598602, 369.4200105833841, 372.61620530853224, 388.53764020815225, 12343.259404435728, 15710.450134245304, 15917.920410397932, 17168.656626867487, 17340.393086241984, 14907.676773735631, 15069.2465376731, 16725.916370418163, 16826.24281907314, 16993.2353044113, 4771.928421073687, 4849.975750121253, 4978.103941290567, 5004.874878128039, 5016.172331565287, 3639.3813051781262, 3813.9618603813883, 4967.70193788372, 5066.417362003362, 5068.5438310552045, 5600.5799565032785, 5856.414358564152, 5868.618539794921, 5968.612040217372, 5977.521798256129, 5780.50865676418, 5924.851878703023, 5954.31525374581, 5966.075258334965, 5981.461668449861, 5271.578273738091, 5272.762725677354, 5278.524932756032, 5280.2607634930755, 5280.656757310762, 20087.49781255466, 20230.898845505824, 20384.796152038438, 20385.4903627409, 20415.591688166154, 1804.6300508395748, 1887.2262372427376, 1896.6775648139712, 1937.4865660599953, 2489.7634724701124, 11877.406129693567, 13101.951843852468, 13193.340332983313, 13223.669408264774, 13632.0, 1688.5694147992306, 1775.1213149490954, 1788.3472532525534, 1803.071418219618, 1847.3413464161918, 66285.66857165731, 67977.66011169912, 69425.3057469424, 69453.0, 70843.29156708419, 9370.250379969586, 9406.0, 9742.853857192147, 9766.560504777302, 9823.607055717834, 11005.504752286166, 12833.037522185874, 12883.613491595268, 12896.871031289567, 12952.28762418076, 5463.672179669233, 5715.8571035724435, 5719.19931209631, 6073.939260607426, 7185.748498802622, 6948.5483443576, 6951.582905025714, 7046.471514636422, 7155.177154627285, 7193.388561972186, 3710.424884142962, 3728.850845966131, 3919.060065267654, 4043.6360727534075, 4181.6236538711055, 1782.7058535341782, 1786.5355007698092, 1790.7224380221087, 1810.8732388732926, 1828.4149072297002, 789.6880732110784, 813.8372325534798, 833.7540425574471, 871.011402058668, 904.8056565333696, 15507.689846203013, 16883.91558042202, 16960.321587136375, 17028.829711702725, 17212.397566085376, 792.9841403171904, 808.8746244332137, 812.5124925045044, 814.8085199978001, 894.8076163624852, 9041.864372034424, 9198.586063627154, 9688.515574221401, 9700.805983880284, 9770.316077874622, 339100.0, 340947.0, 342558.0, 349594.0, 352713.0, 50486.24270635944, 58001.0, 74900.0, 75476.0, 78496.0, 919.2737737187547, 949.368669834566, 962.0331566775346, 963.643451922779, 966.1787480641399, 15250.0, 15295.923520382326, 15334.386624534895, 15906.443274485337, 16213.837861621705, 29053.983110591027, 29744.553831692974, 35003.47494787529, 35088.47367289442, 35739.28521429505, 45896.770516147204, 47029.529704702516, 47234.76382618065, 47413.76293118512, 47737.76131119461, 7543.924560754323, 7548.0, 7640.579768112807, 7733.149353570991, 7913.525188488709, 8544.444611100258, 11644.53421863116, 11696.181267311547, 11724.296542207494, 12218.511259549874, 9700.951495242478, 10103.191744660557, 10202.0, 10448.843267350843, 10657.733556660834, 10040.246981476272, 10064.094231519199, 10097.949510252402, 10166.8474972874, 10328.535215915452, 9706.805863882542, 9939.254555908192, 10181.74545636365, 10298.536565854405, 10989.450527473755, 7513.248675132443, 7636.694532218649, 7640.235976402315, 7662.923370766221, 7752.806179845549, 9704.223662107155, 9786.85319720219, 9914.553845076845, 10305.433201174008, 10522.421266830397], "value": 8026.742901685209, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.2056545507241, 1343.6227866436905, 1416.192770121031, 1651.694436529243, 1676.2289346900418, 6408.48732101432, 6652.966735166329, 6949.478789090819, 7401.555906645598, 7461.925380746191, 7008.439324854012, 7237.782866514, 7238.0, 7423.1092268927805, 7427.851442971138, 2096.748390193179, 2131.8827464489445, 2134.349023547817, 2137.8289736821016, 2144.0673307111456, 1856.303886042734, 1921.1546919355508, 2104.8737075775425, 2133.839962002848, 2204.151401710345, 1884.6324966631512, 1905.0665174064677, 1913.7607799025122, 2041.9285325013627, 2124.341454149219, 2121.8939053047284, 2125.95748085039, 2130.4034870236205, 2130.403487023636, 2132.093860109447, 2096.360610013945, 2113.598416300898, 2118.4809721618303, 2161.384005558424, 2165.2421652421685, 7399.408047356253, 7420.777376678654, 7439.665215065335, 7460.25397460255, 7464.1416237132335, 4285.678574106923, 4412.338149277602, 4413.713108647928, 4415.955840441618, 4416.2713152329825, 2844.416894536636, 2899.043315705812, 2991.4017196560776, 3033.0597514770493, 3047.49716296813, 851.6252848746532, 887.8135591525787, 895.6865097215988, 914.2685851318985, 914.9679761208392, 9731.41611503305, 9771.951140244324, 9789.559469823804, 9792.853107203398, 9808.16630586401, 4035.394690796404, 4128.772917489507, 4237.025484138665, 4238.554951730086, 4288.978555107205, 8584.74245772628, 8592.52741099233, 8606.053334133241, 8607.698730544525, 8609.225169734755, 4460.553944605514, 4530.139273538017, 4532.4334458192725, 4541.3869127668, 4609.0, 4038.3336749436603, 4154.148399578079, 4155.605217504332, 4157.8960525987095, 4194.916101677949, 3474.2530355973586, 3488.5639295088113, 3572.8749493767596, 3680.926381472409, 3682.8895133146048, 1129.2434069173673, 1139.3107170162098, 1141.697450175704, 1167.10716302029, 1172.8475298211179, 769.9884501732479, 811.8877138320539, 823.9052508961427, 833.794904256996, 835.715856608756, 4852.417709874838, 5008.248762685554, 5098.413682426569, 5114.846554603368, 5185.455527169668, 815.3029160068174, 824.6536454688925, 844.7043534762784, 848.6902280667636, 858.4763294390542, 3380.3915295247093, 3438.3639026779624, 3459.152507635595, 3481.912952176165, 3556.7332450066347, 8601.440906341068, 8973.0, 8997.730068097968, 9004.36969412148, 9005.14451127142, 8231.629576669064, 8648.43785153963, 8915.509646969349, 8941.284697224206, 8948.194662480408, 6754.425873800684, 6879.965600171967, 6927.93072069283, 6928.237893831674, 6932.861342773116, 4970.676906001098, 5107.540321371094, 5111.744412779421, 5161.432242453252, 5229.346331708536, 8070.112287648237, 8132.593370331341, 8231.42380033392, 8256.83486330282, 8335.208155225244, 8276.172382761675, 8310.21052999964, 8373.62318695648, 8490.448120872123, 8542.0, 6403.0715546246465, 6453.935460645521, 6489.221293444817, 6505.284418714033, 6517.217933847968, 6868.313168683092, 6978.720851166099, 6982.720691172296, 6993.930060699531, 6998.650067496503, 6369.8726025480155, 6461.160049193575, 6479.708413121327, 6498.252700939453, 6659.800205993828, 6361.968190159205, 6403.935960640334, 6421.486281097407, 6426.678666066585, 6457.5479716419395, 5976.193213916065, 6073.696315184311, 6077.088436734349, 6078.270607527125, 6081.756729730761, 4292.570742925807, 4454.28731402974, 4473.798679059385, 4558.703684260512, 4560.794764235551, 4359.956400435955, 4418.911621767611, 4487.147441986012, 4557.384753058294, 4621.60716339115], "value": 3968.350722423145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.5605493133583, 356.73423299641763, 358.64852444604287, 365.36244253777164, 366.7157952586745, 4831.830885918994, 4876.366072410586, 4892.828750993716, 4904.498705660112, 4922.0, 4810.759462026894, 4842.636802239828, 4859.975700121503, 4865.635077369194, 4884.3406140171155, 3530.7881527108457, 3688.889333320005, 3770.9811450942707, 3796.2597293527774, 3852.325842977468, 3826.9043273918096, 3831.5593706723803, 3846.1538461538557, 3848.3265428549894, 3876.554196267437, 3853.3064048471265, 3857.517810273716, 3862.5558060822946, 3872.1674839909556, 3874.9850077959445, 3702.981485092584, 3755.868544600953, 3802.3535998880257, 3883.5533913599875, 3890.4164375343644, 3496.230829217568, 3498.160441494023, 3506.281212351462, 3527.488514165457, 3533.561842328785, 4737.0, 4741.762911854428, 4746.477887432379, 4746.596539294164, 4750.738709370983, 4350.673699472521, 4408.823647054146, 4460.33095035744, 4464.196444639963, 4466.464024317071, 5071.3407257056715, 5080.390353157608, 5090.567301779353, 5112.718800465973, 5114.667546609458, 3818.369968955119, 3825.7895815730126, 3830.731848770587, 3840.135969406889, 3856.3251430999744, 5097.388313402378, 5151.356080489976, 5155.407128180233, 5359.276497672842, 5392.487713667235, 3859.498265225559, 3875.922481550353, 3909.980450097731, 3922.8234729437245, 3925.8822235332987, 3948.466956960831, 3962.40563915415, 3964.5440774311323, 3965.5836137205756, 3966.4446977423186, 4250.277452833026, 4391.209582275157, 4400.163968845909, 4417.867463976086, 4418.541881179203, 5035.2124995626755, 5051.494850514919, 5051.494850514919, 5053.9494605054215, 5055.494450554988, 1340.766494824744, 1343.9731205376033, 1349.3672656086048, 1353.911995720275, 1358.1918758338772, 919.5027589876825, 958.4393130019017, 959.6257459590765, 961.9326647134774, 968.3124981263381, 4358.302671572596, 4370.847020354272, 4378.43080399546, 4386.8025938832825, 4437.64498840092, 5152.407473140562, 5158.896822063538, 5173.81891633791, 5179.05785330501, 5191.247269146028, 4301.612854843079, 4419.403380543586, 4449.688521803508, 4450.844220452269, 4460.420145381145, 2738.1785464360614, 2743.4238809850153, 2745.217612980331, 2748.931276718098, 2750.9958865014128, 4677.690246730921, 4720.173969555382, 4735.502772208868, 4736.668433209642, 4739.95260047402, 4934.481879402683, 5177.265616018601, 5206.76569554371, 5213.530782229617, 5231.8168864089575, 4711.552402521755, 4725.432948046257, 4730.243161094278, 4732.556570246039, 4736.739479328532, 5105.693658380509, 5117.21326218603, 5119.206522988943, 5138.3063286457345, 5154.845354639367, 4886.413630364379, 4989.176785830297, 5002.399712034579, 5028.698278103326, 5156.381234251764, 4688.9296660549435, 4788.353572267699, 4809.44691360498, 4905.828296009622, 4906.2640603909695, 3699.574548926908, 3705.888823335304, 3706.4810926470855, 3708.2027364116843, 3711.721620878499, 5275.657082289639, 5282.019242783956, 5304.310439642976, 5305.973470132624, 5308.787648494017, 4958.041573578488, 5023.0, 5060.21566657154, 5105.081085404663, 5116.667416617908, 5051.564935843515, 5066.544011039025, 5067.467915868928, 5074.517920797518, 5099.36257967754, 5013.849584512471, 5060.924086138784, 5065.848024559269, 5070.6957582545165, 5073.746312684425, 5022.573081287986, 5093.23601459784, 5116.462771408948, 5124.615653825904, 5143.177091665316, 4941.728204948762, 4951.653384263067, 4988.9501104988485, 4990.15167421532, 4998.925016124688], "value": 3875.3288181898815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2638023941629, 652.8335274505002, 671.6071098407432, 710.357126800246, 742.0353540397482, 12439.813402798954, 13604.727905441885, 13635.045546811727, 13667.453301867925, 13693.65765855854, 12898.226106433596, 13074.673133171651, 13095.607131786039, 13132.474701011972, 14399.136051836897, 614.8739508400768, 642.3640595810161, 758.5638258001644, 778.879273712574, 791.7703865878888, 793.2424534569473, 798.1180795221284, 798.4410912361341, 798.4889670610813, 798.664560884427, 832.4921797703396, 833.687367237286, 833.795720048586, 834.1825011488745, 834.4617721569584, 643.7521554201619, 671.9294474080225, 793.4604468961104, 827.4745536584252, 832.0223737108934, 610.7618028968706, 612.623236709425, 613.2732711736606, 614.213806327901, 615.575253075381, 12996.155249908727, 13108.541201058013, 13116.86883131166, 13165.868341316656, 13174.143680660727, 12025.398730063462, 12082.002024251338, 12311.322877241748, 12358.258504489759, 12423.378831058411, 11581.18931674783, 11685.0, 11716.941415292955, 11907.880921190765, 12055.276683399024, 3947.960520394788, 4034.616711412411, 4066.6340029397497, 4229.027323715532, 4235.9364609530885, 44570.33144502835, 58770.70614646899, 59155.70422147862, 59482.70258648679, 60094.0, 9737.707868763806, 9844.950775246221, 9901.900980990242, 9983.400995940267, 10058.748531286776, 17160.914195428944, 17807.821921780876, 17865.374711885022, 18064.638707226044, 18079.0, 6849.075374824335, 6978.302169782981, 7047.0, 7119.21688614252, 7309.488335816442, 3720.776753394805, 3733.9813300933865, 3744.7940363279736, 3767.585565587783, 3788.242351529705, 2857.7570906473184, 2918.7810914181523, 2935.530315149566, 2940.147357266369, 2947.189522881225, 473.8673171511982, 475.6480204648535, 476.0289010418707, 481.5978657820689, 489.23434824499543, 552.6269767906647, 583.1486030395586, 587.5563949218313, 591.9171316015761, 594.3699678340972, 8233.958830205811, 8547.487150770974, 8600.78498037554, 8799.208071273617, 8844.690435834844, 594.6045879490177, 627.8555932135635, 639.0892977507034, 640.6444423344996, 642.5855323316434, 4002.679785617144, 4245.320748680197, 4260.573942605776, 4272.807723652443, 4309.41822853917, 66469.6676516624, 66746.0, 66988.0, 68848.6557567209, 69006.30993690099, 46267.30599041017, 51102.488975110515, 57829.71085144632, 58937.0, 60264.698676507214, 53045.204321935205, 53451.0, 53681.19478207908, 53794.7310263454, 54395.45604543983, 7808.180141085104, 8423.70517031901, 8450.915490845258, 8454.0, 8594.613242403982, 36378.636213637525, 36880.26239475249, 38410.6158938407, 38779.80610097044, 39419.2116157681, 45155.322670159316, 48677.513224868715, 49645.503544964085, 49773.0, 51105.0, 9410.153086222273, 9704.417734935927, 9880.752981175528, 9942.652007179713, 10047.598096076075, 10950.671479855617, 10953.507092181031, 11122.610708625483, 11324.037456816262, 11475.885241147482, 9674.177694896012, 10305.278630495794, 11521.078313735048, 12134.26333040245, 12343.13598048128, 11471.311721296748, 11793.52091133135, 11816.468258928197, 12285.38573071325, 12290.692732681755, 11873.008614219301, 12233.388330583613, 12267.815982760087, 12280.140390172603, 12603.495860165858, 9905.533063427743, 9975.551100200653, 10322.845157322796, 10327.32872363294, 10387.169026477712, 8612.569371531274, 9692.418454892448, 9927.305088643725, 9991.100800927952, 10147.391156530632], "value": 6288.477543202598, "unit": "score"}], "name": "dromaeo_css", "value": 6281.49430343009, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 129.0, 170.0, 134.0, 125.0, 132.0, 131.0, 153.0, 131.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 161.0, 165.0, 163.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 78.0, 77.0, 76.0, 77.0, 96.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 107.0, 85.0, 84.0, 86.0, 99.0, 85.0, 86.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 127.0, 127.0, 128.0, 128.0, 127.0, 128.0, 127.0], "value": 127.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 69.0, 65.0, 64.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 69.0, 65.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 88.0, 86.0, 86.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 136.0, 139.0, 137.0, 133.0, 137.0, 137.0, 133.0, 178.0, 137.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 179.0, 179.0, 176.0, 177.0, 181.0, 179.0, 179.0, 174.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0, 68.0, 69.0, 73.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1563.6999999999998, "alertThreshold": 2.0}]} 15:00:07 INFO - Return code: 0 15:00:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:00:07 INFO - # TBPL SUCCESS # 15:00:07 INFO - Running post-action listener: _resource_record_post_action 15:00:07 INFO - [mozharness: 2016-12-21 23:00:07.321107Z] Finished run-tests step (success) 15:00:07 INFO - Running post-run listener: _resource_record_post_run 15:00:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393486336; Read time: 8; Write time: 225768 15:00:07 INFO - TinderboxPrint: CPU usage
13.1% 15:00:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:00:07 INFO - TinderboxPrint: I/O write bytes / time
393,486,336 / 225,768 15:00:07 INFO - TinderboxPrint: CPU idle
8,340.1 (86.9%) 15:00:07 INFO - TinderboxPrint: CPU user
1,215.9 (12.7%) 15:00:07 INFO - TinderboxPrint: Swap in / out
0 / 0 15:00:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99491840; Read time: 0; Write time: 67992 15:00:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 282198016; Read time: 0; Write time: 154476 15:00:07 INFO - Running post-run listener: _upload_blobber_files 15:00:07 INFO - Blob upload gear active. 15:00:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:07 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 15:00:07 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:00:07 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:00:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:09 INFO - (blobuploader) - INFO - Done attempting. 15:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:10 INFO - (blobuploader) - INFO - Done attempting. 15:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:10 INFO - (blobuploader) - INFO - Done attempting. 15:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:14 INFO - (blobuploader) - INFO - Done attempting. 15:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:14 INFO - Return code: 0 15:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/58e6955aa90b70c7bba7b952b50d0078b4636960aa7154333285447dfae78b89bd315e328c805102852b59c3cbcdc28d21cdb0e09becbe595b8dd7e810b8c840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c40df60762e7e39355ce17aac3539ec0a8b8d6c0326d785204fbc0d77dfc33b3ccd8b96d31f9257273930bf89d290bf7b1e79feb4afa170a591a80dad958598", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/646605f703610d673acfe3d80bb6b399058960c64f6c369527ff618e50f2da8c6399b53a0af41ed816e49d5bbdda081cf5fd5e4db6e89e983c58c0a31b4a9c84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6a927bcdb6622853ac68cab3d282365778d0b5e174ac6684d42e2be7e2aaff034d673cd6d6ac0be790a40950ff3ec5435605e64e2e403a8ea79fb2b013df1920"} 15:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:14 INFO - Contents: 15:00:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/58e6955aa90b70c7bba7b952b50d0078b4636960aa7154333285447dfae78b89bd315e328c805102852b59c3cbcdc28d21cdb0e09becbe595b8dd7e810b8c840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c40df60762e7e39355ce17aac3539ec0a8b8d6c0326d785204fbc0d77dfc33b3ccd8b96d31f9257273930bf89d290bf7b1e79feb4afa170a591a80dad958598", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/646605f703610d673acfe3d80bb6b399058960c64f6c369527ff618e50f2da8c6399b53a0af41ed816e49d5bbdda081cf5fd5e4db6e89e983c58c0a31b4a9c84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6a927bcdb6622853ac68cab3d282365778d0b5e174ac6684d42e2be7e2aaff034d673cd6d6ac0be790a40950ff3ec5435605e64e2e403a8ea79fb2b013df1920"} 15:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:14 INFO - Copying logs to upload dir... 15:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.503441 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-21 15:00:14.280455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 15:00:14.284613) ========= 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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/58e6955aa90b70c7bba7b952b50d0078b4636960aa7154333285447dfae78b89bd315e328c805102852b59c3cbcdc28d21cdb0e09becbe595b8dd7e810b8c840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c40df60762e7e39355ce17aac3539ec0a8b8d6c0326d785204fbc0d77dfc33b3ccd8b96d31f9257273930bf89d290bf7b1e79feb4afa170a591a80dad958598", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/646605f703610d673acfe3d80bb6b399058960c64f6c369527ff618e50f2da8c6399b53a0af41ed816e49d5bbdda081cf5fd5e4db6e89e983c58c0a31b4a9c84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6a927bcdb6622853ac68cab3d282365778d0b5e174ac6684d42e2be7e2aaff034d673cd6d6ac0be790a40950ff3ec5435605e64e2e403a8ea79fb2b013df1920"} build_url:https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011660 build_url: 'https://queue.taskcluster.net/v1/task/f2rub2ANQvuGjIOvcnZuhg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/58e6955aa90b70c7bba7b952b50d0078b4636960aa7154333285447dfae78b89bd315e328c805102852b59c3cbcdc28d21cdb0e09becbe595b8dd7e810b8c840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c40df60762e7e39355ce17aac3539ec0a8b8d6c0326d785204fbc0d77dfc33b3ccd8b96d31f9257273930bf89d290bf7b1e79feb4afa170a591a80dad958598", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/646605f703610d673acfe3d80bb6b399058960c64f6c369527ff618e50f2da8c6399b53a0af41ed816e49d5bbdda081cf5fd5e4db6e89e983c58c0a31b4a9c84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6a927bcdb6622853ac68cab3d282365778d0b5e174ac6684d42e2be7e2aaff034d673cd6d6ac0be790a40950ff3ec5435605e64e2e403a8ea79fb2b013df1920"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 15:00:14.311615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 15:00:14.311951) ========= 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=0e2a256762fed810e2f0f810000001b3-1482359964.15791-889953903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 15:00:14.397366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 15:00:14.397791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 15:00:14.398219) ========= ========= Total master_lag: 0.17 =========