builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-057 starttime: 1505239883.31 results: success (0) revision: 4069ad6982eabbab5b30fd45de159fe746e5a517 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.312127) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.312631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.312949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.341635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.342181) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 11:11:23-- 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% 39.1M=0s 2017-09-12 11:11:23 (39.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133035 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.512275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.512611) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.563326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:23.563669) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4069ad6982eabbab5b30fd45de159fe746e5a517 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4069ad6982eabbab5b30fd45de159fe746e5a517 --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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 11:11:23,637 truncating revision to first 12 chars 2017-09-12 11:11:23,637 Setting DEBUG logging. 2017-09-12 11:11:23,637 attempt 1/10 2017-09-12 11:11:23,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4069ad6982ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 11:11:24,048 unpacking tar archive at: mozilla-central-4069ad6982ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:24.295441) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:24.295818) ========= script_repo_revision: 4069ad6982eabbab5b30fd45de159fe746e5a517 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:24.296266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:24.296570) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:11:24.310395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-12 11:11:24.310844) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:24 INFO - MultiFileLogger online at 20170912 11:11:24 in /builds/slave/test 11:11:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:11:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:11:24 INFO - {'append_to_log': False, 11:11:24 INFO - 'base_work_dir': '/builds/slave/test', 11:11:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:11:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:11:24 INFO - 'branch': 'Firefox-Non-PGO', 11:11:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:24 INFO - 'code_coverage': False, 11:11:24 INFO - 'config_files': ('talos/linux_config.py',), 11:11:24 INFO - 'default_actions': ('clobber', 11:11:24 INFO - 'read-buildbot-config', 11:11:24 INFO - 'download-and-extract', 11:11:24 INFO - 'populate-webroot', 11:11:24 INFO - 'create-virtualenv', 11:11:24 INFO - 'install', 11:11:24 INFO - 'setup-mitmproxy', 11:11:24 INFO - 'run-tests'), 11:11:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:24 INFO - 'disable_ccov_upload': False, 11:11:24 INFO - 'disable_stylo': False, 11:11:24 INFO - 'download_minidump_stackwalk': True, 11:11:24 INFO - 'download_symbols': 'ondemand', 11:11:24 INFO - 'enable_stylo': False, 11:11:24 INFO - 'enable_webrender': False, 11:11:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:11:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:24 INFO - 'gecko_profile': False, 11:11:24 INFO - 'gecko_profile_interval': 0, 11:11:24 INFO - 'installer_path': 'installer.exe', 11:11:24 INFO - 'log_level': 'info', 11:11:24 INFO - 'log_name': 'talos', 11:11:24 INFO - 'log_to_console': True, 11:11:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:24 INFO - 'opt_config_files': (), 11:11:24 INFO - 'pip_index': False, 11:11:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:11:24 INFO - 'system_bits': '32', 11:11:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:24 INFO - 'title': 'talos-linux64-ix-057', 11:11:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:24 INFO - 'use_talos_json': True, 11:11:24 INFO - 'verify': 'False', 11:11:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:11:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:24 INFO - 'work_dir': 'build'} 11:11:24 INFO - [mozharness: 2017-09-12 18:11:24.531456Z] Running clobber step. 11:11:24 INFO - Running pre-action listener: _resource_record_pre_action 11:11:24 INFO - Running main action method: clobber 11:11:24 INFO - rmtree: /builds/slave/test/build 11:11:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:11:25 INFO - Running post-action listener: _resource_record_post_action 11:11:25 INFO - [mozharness: 2017-09-12 18:11:25.568814Z] Finished clobber step (success) 11:11:25 INFO - [mozharness: 2017-09-12 18:11:25.568912Z] Running read-buildbot-config step. 11:11:25 INFO - Running pre-action listener: _resource_record_pre_action 11:11:25 INFO - Running main action method: read_buildbot_config 11:11:25 INFO - Using buildbot properties: 11:11:25 INFO - { 11:11:25 INFO - "project": "", 11:11:25 INFO - "product": "firefox", 11:11:25 INFO - "who": "ryanvm@gmail.com", 11:11:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:11:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:11:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:11:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:11:25 INFO - "stage_platform": "linux64", 11:11:25 INFO - "basedir": "/builds/slave/test", 11:11:25 INFO - "buildnumber": 14, 11:11:25 INFO - "platform": "ubuntu64_hw", 11:11:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:11:25 INFO - "slavebuilddir": "test", 11:11:25 INFO - "taskId": "N763P_NNQCGaHqQvfUuktA", 11:11:25 INFO - "branch": "mozilla-central", 11:11:25 INFO - "script_repo_revision": "production", 11:11:25 INFO - "revision": "4069ad6982eabbab5b30fd45de159fe746e5a517", 11:11:25 INFO - "slavename": "talos-linux64-ix-057", 11:11:25 INFO - "repo_path": "mozilla-central" 11:11:25 INFO - } 11:11:25 INFO - Finding installer, test and symbols from parent task. 11:11:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N763P_NNQCGaHqQvfUuktA'}, attempt #1 11:11:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N763P_NNQCGaHqQvfUuktA'}, attempt #1 11:11:26 INFO - Task dependencies: FQjg94SATyS0BGw0f0JD1g 11:11:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g'}, attempt #1 11:11:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 11:11:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.test_packages.json 11:11:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.crashreporter-symbols.zip 11:11:27 INFO - Running post-action listener: _resource_record_post_action 11:11:27 INFO - [mozharness: 2017-09-12 18:11:27.362326Z] Finished read-buildbot-config step (success) 11:11:27 INFO - [mozharness: 2017-09-12 18:11:27.362541Z] Running download-and-extract step. 11:11:27 INFO - Running pre-action listener: _resource_record_pre_action 11:11:27 INFO - Running main action method: download_and_extract 11:11:27 INFO - mkdir: /builds/slave/test/build/tests 11:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:27 INFO - trying https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.test_packages.json 11:11:27 INFO - Downloading https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:11:27 INFO - Downloaded 989 bytes. 11:11:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:11:27 INFO - Using the following test package requirements: 11:11:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:11:27 INFO - u'common': [u'target.common.tests.zip'], 11:11:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:11:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:11:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:11:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:11:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:11:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:11:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:11:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:11:27 INFO - u'target.web-platform.tests.tar.gz'], 11:11:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:11:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.common.tests.zip 11:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.common.tests.zip into memory 11:11:30 INFO - Content-Length response header: 55043968 11:11:30 INFO - Bytes received: 55043968 11:11:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.talos.tests.zip 11:11:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:11:41 INFO - Fetch https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.talos.tests.zip into memory 11:11:42 INFO - Content-Length response header: 14499231 11:11:42 INFO - Bytes received: 14499231 11:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:42 INFO - trying https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 11:11:42 INFO - Downloading https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:11:46 INFO - Downloaded 63011396 bytes. 11:11:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 11:11:46 INFO - mkdir: /builds/slave/test/properties 11:11:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:11:46 INFO - Writing to file /builds/slave/test/properties/build_url 11:11:46 INFO - Contents: 11:11:46 INFO - build_url:https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - Running post-action listener: find_tests_for_verification 11:11:46 INFO - Running post-action listener: set_extra_try_arguments 11:11:46 INFO - [mozharness: 2017-09-12 18:11:46.022124Z] Finished download-and-extract step (success) 11:11:46 INFO - [mozharness: 2017-09-12 18:11:46.022351Z] Running populate-webroot step. 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: populate_webroot 11:11:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:11:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['tresize', 11:11:46 INFO - 'tcanvasmark']}, 11:11:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:11:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['dromaeo_css', 11:11:46 INFO - 'kraken']}, 11:11:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:11:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'tests': ['damp', 'tps']}, 11:11:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['damp', 'tps']}, 11:11:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:11:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['dromaeo_dom']}, 11:11:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:11:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['basic_compositor_video', 11:11:46 INFO - 'glvideo']}, 11:11:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:11:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['ts_paint_webext', 11:11:46 INFO - 'tp5o_webext']}, 11:11:46 INFO - 'other-e10s': {'tests': ['a11yr', 11:11:46 INFO - 'ts_paint', 11:11:46 INFO - 'tpaint', 11:11:46 INFO - 'sessionrestore', 11:11:46 INFO - 'sessionrestore_many_windows', 11:11:46 INFO - 'sessionrestore_no_auto_restore', 11:11:46 INFO - 'tabpaint']}, 11:11:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['a11yr', 11:11:46 INFO - 'ts_paint', 11:11:46 INFO - 'tpaint', 11:11:46 INFO - 'sessionrestore', 11:11:46 INFO - 'sessionrestore_many_windows', 11:11:46 INFO - 'sessionrestore_no_auto_restore', 11:11:46 INFO - 'tabpaint']}, 11:11:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:11:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:11:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['bloom_basic_singleton']}, 11:11:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['bloom_basic']}, 11:11:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:11:46 INFO - 'tsvgr_opacity', 11:11:46 INFO - 'tart', 11:11:46 INFO - 'tscrollx', 11:11:46 INFO - 'tsvg_static']}, 11:11:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['tsvgx', 11:11:46 INFO - 'tsvgr_opacity', 11:11:46 INFO - 'tart', 11:11:46 INFO - 'tscrollx', 11:11:46 INFO - 'tsvg_static']}, 11:11:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:11:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo'], 11:11:46 INFO - 'tests': ['tp5o']}, 11:11:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:46 INFO - 'talos_options': ['--mitmproxy', 11:11:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:46 INFO - '--firstNonBlankPaint'], 11:11:46 INFO - 'tests': ['tp6_google', 11:11:46 INFO - 'tp6_youtube', 11:11:46 INFO - 'tp6_amazon', 11:11:46 INFO - 'tp6_facebook']}, 11:11:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo', 11:11:46 INFO - '--mitmproxy', 11:11:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:46 INFO - '--firstNonBlankPaint'], 11:11:46 INFO - 'tests': ['tp6_google', 11:11:46 INFO - 'tp6_youtube', 11:11:46 INFO - 'tp6_amazon', 11:11:46 INFO - 'tp6_facebook']}, 11:11:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:11:46 INFO - 'talos_options': ['--stylo-threads=1', 11:11:46 INFO - '--mitmproxy', 11:11:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:11:46 INFO - '--firstNonBlankPaint'], 11:11:46 INFO - 'tests': ['tp6_google', 11:11:46 INFO - 'tp6_youtube', 11:11:46 INFO - 'tp6_amazon', 11:11:46 INFO - 'tp6_facebook']}, 11:11:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--xperf_path', 11:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:46 INFO - 'tests': ['tp5n']}, 11:11:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:11:46 INFO - 'talos_options': ['--disable-stylo', 11:11:46 INFO - '--xperf_path', 11:11:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:11:46 INFO - 'tests': ['tp5n']}}} 11:11:46 INFO - Running post-action listener: _resource_record_post_action 11:11:46 INFO - [mozharness: 2017-09-12 18:11:46.043101Z] Finished populate-webroot step (success) 11:11:46 INFO - [mozharness: 2017-09-12 18:11:46.043204Z] Running create-virtualenv step. 11:11:46 INFO - Running pre-action listener: _resource_record_pre_action 11:11:46 INFO - Running main action method: create_virtualenv 11:11:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:11:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:11:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:11:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:11:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:11:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:11:46 INFO - Installing distribute.............................................................................................................................................................................................done. 11:11:46 INFO - Installing pip...............done. 11:11:46 INFO - Return code: 0 11:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:11:47 INFO - Reading from file tmpfile_stdout 11:11:47 INFO - Output received: 11:11:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:11:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:47 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:11:47 INFO - Using env: {'DISPLAY': ':0', 11:11:47 INFO - 'HOME': '/home/cltbld', 11:11:47 INFO - 'LANG': 'en_US.UTF-8', 11:11:47 INFO - 'LANGUAGE': 'en_US:en', 11:11:47 INFO - 'LOGNAME': 'cltbld', 11:11:47 INFO - 'MAIL': '/var/mail/cltbld', 11:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:47 INFO - 'MOZ_NO_REMOTE': '1', 11:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:47 INFO - 'NO_EM_RESTART': '1', 11:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:47 INFO - 'PWD': '/builds/slave/test', 11:11:47 INFO - 'SHELL': '/bin/bash', 11:11:47 INFO - 'SHLVL': '1', 11:11:47 INFO - 'TERM': 'linux', 11:11:47 INFO - 'TMOUT': '86400', 11:11:47 INFO - 'USER': 'cltbld', 11:11:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:47 INFO - '_': '/tools/buildbot/bin/python'} 11:11:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:11:55 INFO - Downloading/unpacking pip>=1.5 11:11:55 INFO - Running setup.py egg_info for package pip 11:11:55 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires' 11:11:55 INFO - warnings.warn(msg) 11:11:55 INFO - warning: no previously-included files found matching '.coveragerc' 11:11:55 INFO - warning: no previously-included files found matching '.mailmap' 11:11:55 INFO - warning: no previously-included files found matching '.travis.yml' 11:11:55 INFO - warning: no previously-included files found matching '.landscape.yml' 11:11:55 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile' 11:11:55 INFO - warning: no previously-included files found matching 'tox.ini' 11:11:55 INFO - warning: no previously-included files found matching 'dev-requirements.txt' 11:11:55 INFO - warning: no previously-included files found matching 'appveyor.yml' 11:11:55 INFO - no previously-included directories found matching '.github' 11:11:55 INFO - no previously-included directories found matching '.travis' 11:11:55 INFO - no previously-included directories found matching 'docs/_build' 11:11:55 INFO - no previously-included directories found matching 'contrib' 11:11:55 INFO - no previously-included directories found matching 'tasks' 11:11:55 INFO - no previously-included directories found matching 'tests' 11:11:55 INFO - Installing collected packages: pip 11:11:55 INFO - Found existing installation: pip 1.1 11:11:55 INFO - Uninstalling pip: 11:11:55 INFO - Successfully uninstalled pip 11:11:55 INFO - Running setup.py install for pip 11:11:55 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires' 11:11:55 INFO - warnings.warn(msg) 11:11:55 INFO - warning: no previously-included files found matching '.coveragerc' 11:11:55 INFO - warning: no previously-included files found matching '.mailmap' 11:11:55 INFO - warning: no previously-included files found matching '.travis.yml' 11:11:55 INFO - warning: no previously-included files found matching '.landscape.yml' 11:11:55 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile' 11:11:55 INFO - warning: no previously-included files found matching 'tox.ini' 11:11:55 INFO - warning: no previously-included files found matching 'dev-requirements.txt' 11:11:55 INFO - warning: no previously-included files found matching 'appveyor.yml' 11:11:55 INFO - no previously-included directories found matching '.github' 11:11:55 INFO - no previously-included directories found matching '.travis' 11:11:55 INFO - no previously-included directories found matching 'docs/_build' 11:11:55 INFO - no previously-included directories found matching 'contrib' 11:11:55 INFO - no previously-included directories found matching 'tasks' 11:11:55 INFO - no previously-included directories found matching 'tests' 11:11:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:11:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:11:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:11:55 INFO - Successfully installed pip 11:11:55 INFO - Cleaning up... 11:11:55 INFO - Return code: 0 11:11:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:55 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:11:55 INFO - Using env: {'DISPLAY': ':0', 11:11:55 INFO - 'HOME': '/home/cltbld', 11:11:55 INFO - 'LANG': 'en_US.UTF-8', 11:11:55 INFO - 'LANGUAGE': 'en_US:en', 11:11:55 INFO - 'LOGNAME': 'cltbld', 11:11:55 INFO - 'MAIL': '/var/mail/cltbld', 11:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:55 INFO - 'MOZ_NO_REMOTE': '1', 11:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:55 INFO - 'NO_EM_RESTART': '1', 11:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:55 INFO - 'PWD': '/builds/slave/test', 11:11:55 INFO - 'SHELL': '/bin/bash', 11:11:55 INFO - 'SHLVL': '1', 11:11:55 INFO - 'TERM': 'linux', 11:11:55 INFO - 'TMOUT': '86400', 11:11:55 INFO - 'USER': 'cltbld', 11:11:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:55 INFO - '_': '/tools/buildbot/bin/python'} 11:11:56 INFO - Collecting psutil>=3.1.1 11:11:57 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/psutil-3.1.1.tar.gz (247kB) 11:11:57 INFO - Installing collected packages: psutil 11:11:57 INFO - Running setup.py install for psutil: started 11:11:58 INFO - Running setup.py install for psutil: finished with status 'done' 11:11:58 INFO - Successfully installed psutil-3.1.1 11:11:58 INFO - Return code: 0 11:11:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:11:58 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:11:58 INFO - Using env: {'DISPLAY': ':0', 11:11:58 INFO - 'HOME': '/home/cltbld', 11:11:58 INFO - 'LANG': 'en_US.UTF-8', 11:11:58 INFO - 'LANGUAGE': 'en_US:en', 11:11:58 INFO - 'LOGNAME': 'cltbld', 11:11:58 INFO - 'MAIL': '/var/mail/cltbld', 11:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:11:58 INFO - 'MOZ_NO_REMOTE': '1', 11:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:11:58 INFO - 'NO_EM_RESTART': '1', 11:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:11:58 INFO - 'PWD': '/builds/slave/test', 11:11:58 INFO - 'SHELL': '/bin/bash', 11:11:58 INFO - 'SHLVL': '1', 11:11:58 INFO - 'TERM': 'linux', 11:11:58 INFO - 'TMOUT': '86400', 11:11:58 INFO - 'USER': 'cltbld', 11:11:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:11:58 INFO - '_': '/tools/buildbot/bin/python'} 11:11:58 INFO - Collecting mozsystemmonitor==0.3 11:11:59 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/mozsystemmonitor-0.3.tar.gz 11:12:00 INFO - Requirement already satisfied: psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:00 INFO - Installing collected packages: mozsystemmonitor 11:12:00 INFO - Running setup.py install for mozsystemmonitor: started 11:12:00 INFO - Running setup.py install for mozsystemmonitor: finished with status 'done' 11:12:00 INFO - Successfully installed mozsystemmonitor-0.3 11:12:00 INFO - Return code: 0 11:12:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:00 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:12:00 INFO - Using env: {'DISPLAY': ':0', 11:12:00 INFO - 'HOME': '/home/cltbld', 11:12:00 INFO - 'LANG': 'en_US.UTF-8', 11:12:00 INFO - 'LANGUAGE': 'en_US:en', 11:12:00 INFO - 'LOGNAME': 'cltbld', 11:12:00 INFO - 'MAIL': '/var/mail/cltbld', 11:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:00 INFO - 'MOZ_NO_REMOTE': '1', 11:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:00 INFO - 'NO_EM_RESTART': '1', 11:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:00 INFO - 'PWD': '/builds/slave/test', 11:12:00 INFO - 'SHELL': '/bin/bash', 11:12:00 INFO - 'SHLVL': '1', 11:12:00 INFO - 'TERM': 'linux', 11:12:00 INFO - 'TMOUT': '86400', 11:12:00 INFO - 'USER': 'cltbld', 11:12:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:00 INFO - '_': '/tools/buildbot/bin/python'} 11:12:00 INFO - Collecting jsonschema==2.5.1 11:12:01 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/jsonschema-2.5.1-py2.py3-none-any.whl 11:12:01 INFO - Collecting functools32; python_version == "2.7" (from jsonschema==2.5.1) 11:12:03 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/functools32-3.2.3-2.tar.gz 11:12:03 INFO - Installing collected packages: functools32, jsonschema 11:12:03 INFO - Running setup.py install for functools32: started 11:12:03 INFO - Running setup.py install for functools32: finished with status 'done' 11:12:03 INFO - Successfully installed functools32-3.2.3.post2 jsonschema-2.5.1 11:12:03 INFO - Return code: 0 11:12:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12: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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:03 INFO - Requirement already satisfied: functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:03 INFO - Return code: 0 11:12:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12: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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:12:03 INFO - Using env: {'DISPLAY': ':0', 11:12:03 INFO - 'HOME': '/home/cltbld', 11:12:03 INFO - 'LANG': 'en_US.UTF-8', 11:12:03 INFO - 'LANGUAGE': 'en_US:en', 11:12:03 INFO - 'LOGNAME': 'cltbld', 11:12:03 INFO - 'MAIL': '/var/mail/cltbld', 11:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:03 INFO - 'MOZ_NO_REMOTE': '1', 11:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:03 INFO - 'NO_EM_RESTART': '1', 11:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:03 INFO - 'PWD': '/builds/slave/test', 11:12:03 INFO - 'SHELL': '/bin/bash', 11:12:03 INFO - 'SHLVL': '1', 11:12:03 INFO - 'TERM': 'linux', 11:12:03 INFO - 'TMOUT': '86400', 11:12:03 INFO - 'USER': 'cltbld', 11:12:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:03 INFO - '_': '/tools/buildbot/bin/python'} 11:12:04 INFO - Collecting blobuploader==1.2.4 11:12:05 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blobuploader-1.2.4.tar.gz 11:12:05 INFO - Collecting requests==1.2.3. (from blobuploader==1.2.4) 11:12:06 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/requests-1.2.3.tar.gz (348kB) 11:12:07 INFO - Collecting docopt==0.6.1 (from blobuploader==1.2.4) 11:12:08 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/docopt-0.6.1.tar.gz 11:12:08 INFO - Installing collected packages: requests, docopt, blobuploader 11:12:08 INFO - Running setup.py install for requests: started 11:12:08 INFO - Running setup.py install for requests: finished with status 'done' 11:12:08 INFO - Running setup.py install for docopt: started 11:12:09 INFO - Running setup.py install for docopt: finished with status 'done' 11:12:09 INFO - Running setup.py install for blobuploader: started 11:12:09 INFO - Running setup.py install for blobuploader: finished with status 'done' 11:12:09 INFO - Successfully installed blobuploader-1.2.4 docopt-0.6.1 requests-1.2.3 11:12:09 INFO - Return code: 0 11:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:09 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:09 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:09 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:09 INFO - Using env: {'DISPLAY': ':0', 11:12:09 INFO - 'HOME': '/home/cltbld', 11:12:09 INFO - 'LANG': 'en_US.UTF-8', 11:12:09 INFO - 'LANGUAGE': 'en_US:en', 11:12:09 INFO - 'LOGNAME': 'cltbld', 11:12:09 INFO - 'MAIL': '/var/mail/cltbld', 11:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:09 INFO - 'MOZ_NO_REMOTE': '1', 11:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:09 INFO - 'NO_EM_RESTART': '1', 11:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:09 INFO - 'PWD': '/builds/slave/test', 11:12:09 INFO - 'SHELL': '/bin/bash', 11:12:09 INFO - 'SHLVL': '1', 11:12:09 INFO - 'TERM': 'linux', 11:12:09 INFO - 'TMOUT': '86400', 11:12:09 INFO - 'USER': 'cltbld', 11:12:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:09 INFO - '_': '/tools/buildbot/bin/python'} 11:12:09 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser 11:12:09 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash 11:12:09 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug 11:12:09 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess 11:12:10 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile 11:12:11 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner 11:12:11 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:11 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest 11:12:11 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion 11:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:11 INFO - Running setup.py install for manifestparser: started 11:12:11 INFO - Running setup.py install for manifestparser: finished with status 'done' 11:12:11 INFO - Running setup.py install for mozcrash: started 11:12:11 INFO - Running setup.py install for mozcrash: finished with status 'done' 11:12:11 INFO - Running setup.py install for mozdebug: started 11:12:11 INFO - Running setup.py install for mozdebug: finished with status 'done' 11:12:11 INFO - Running setup.py install for mozdevice: started 11:12:11 INFO - Running setup.py install for mozdevice: finished with status 'done' 11:12:11 INFO - Running setup.py install for mozfile: started 11:12:11 INFO - Running setup.py install for mozfile: finished with status 'done' 11:12:11 INFO - Running setup.py install for mozhttpd: started 11:12:12 INFO - Running setup.py install for mozhttpd: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozinfo: started 11:12:12 INFO - Running setup.py install for mozinfo: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozInstall: started 11:12:12 INFO - Running setup.py install for mozInstall: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozleak: started 11:12:12 INFO - Running setup.py install for mozleak: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozlog: started 11:12:12 INFO - Running setup.py install for mozlog: finished with status 'done' 11:12:12 INFO - Running setup.py install for moznetwork: started 11:12:12 INFO - Running setup.py install for moznetwork: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozprocess: started 11:12:12 INFO - Running setup.py install for mozprocess: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozprofile: started 11:12:12 INFO - Running setup.py install for mozprofile: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozrunner: started 11:12:12 INFO - Running setup.py install for mozrunner: finished with status 'done' 11:12:12 INFO - Running setup.py install for mozscreenshot: started 11:12:12 INFO - Running setup.py install for mozscreenshot: finished with status 'done' 11:12:12 INFO - Running setup.py install for moztest: started 11:12:13 INFO - Running setup.py install for moztest: finished with status 'done' 11:12:13 INFO - Running setup.py install for mozversion: started 11:12:13 INFO - Running setup.py install for mozversion: finished with status 'done' 11:12:13 INFO - Successfully installed manifestparser-1.1 mozInstall-1.13 mozcrash-1.0 mozdebug-0.1 mozdevice-0.51 mozfile-1.2 mozhttpd-0.7 mozinfo-0.10 mozleak-0.1 mozlog-3.5 moznetwork-0.27 mozprocess-0.25 mozprofile-0.28 mozrunner-6.13 mozscreenshot-0.1 moztest-0.8 mozversion-1.4 11:12:13 INFO - Return code: 0 11:12:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:13 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:13 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:12:13 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:13 INFO - Using env: {'DISPLAY': ':0', 11:12:13 INFO - 'HOME': '/home/cltbld', 11:12:13 INFO - 'LANG': 'en_US.UTF-8', 11:12:13 INFO - 'LANGUAGE': 'en_US:en', 11:12:13 INFO - 'LOGNAME': 'cltbld', 11:12:13 INFO - 'MAIL': '/var/mail/cltbld', 11:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:13 INFO - 'MOZ_NO_REMOTE': '1', 11:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:13 INFO - 'NO_EM_RESTART': '1', 11:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:13 INFO - 'PWD': '/builds/slave/test', 11:12:13 INFO - 'SHELL': '/bin/bash', 11:12:13 INFO - 'SHLVL': '1', 11:12:13 INFO - 'TERM': 'linux', 11:12:13 INFO - 'TMOUT': '86400', 11:12:13 INFO - 'USER': 'cltbld', 11:12:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:13 INFO - '_': '/tools/buildbot/bin/python'} 11:12:13 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash 11:12:14 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)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess 11:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:12:14 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:12:15 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner 11:12:15 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)) 11:12:15 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:12:15 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:12:15 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion 11:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:12:15 INFO - Requirement already satisfied: 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)) 11:12:15 INFO - Requirement already satisfied: 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)) 11:12:15 INFO - Requirement already satisfied: mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:12:15 INFO - Requirement already satisfied: moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:15 INFO - Requirement already satisfied: mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:12:15 INFO - Requirement already satisfied: requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:12:15 INFO - Collecting blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:16 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blessings-1.6.tar.gz 11:12:16 INFO - Installing collected packages: blessings 11:12:16 INFO - Running setup.py install for blessings: started 11:12:16 INFO - Running setup.py install for blessings: finished with status 'done' 11:12:16 INFO - Successfully installed blessings-1.6 11:12:16 INFO - Return code: 0 11:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:17 INFO - Reading from file tmpfile_stdout 11:12:17 INFO - Reading from file tmpfile_stderr 11:12:17 INFO - Current package versions: 11:12:17 INFO - blessings == 1.6 11:12:17 INFO - blobuploader == 1.2.4 11:12:17 INFO - docopt == 0.6.1 11:12:17 INFO - functools32 == 3.2.3.post2 11:12:17 INFO - jsonschema == 2.5.1 11:12:17 INFO - manifestparser == 1.1 11:12:17 INFO - mozInstall == 1.13 11:12:17 INFO - mozcrash == 1.0 11:12:17 INFO - mozdebug == 0.1 11:12:17 INFO - mozdevice == 0.51 11:12:17 INFO - mozfile == 1.2 11:12:17 INFO - mozhttpd == 0.7 11:12:17 INFO - mozinfo == 0.10 11:12:17 INFO - mozleak == 0.1 11:12:17 INFO - mozlog == 3.5 11:12:17 INFO - moznetwork == 0.27 11:12:17 INFO - mozprocess == 0.25 11:12:17 INFO - mozprofile == 0.28 11:12:17 INFO - mozrunner == 6.13 11:12:17 INFO - mozscreenshot == 0.1 11:12:17 INFO - mozsystemmonitor == 0.3 11:12:17 INFO - moztest == 0.8 11:12:17 INFO - mozversion == 1.4 11:12:17 INFO - psutil == 3.1.1 11:12:17 INFO - requests == 1.2.3 11:12:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:17 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/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:17 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:12:17 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:12:17 INFO - Using env: {'DISPLAY': ':0', 11:12:17 INFO - 'HOME': '/home/cltbld', 11:12:17 INFO - 'LANG': 'en_US.UTF-8', 11:12:17 INFO - 'LANGUAGE': 'en_US:en', 11:12:17 INFO - 'LOGNAME': 'cltbld', 11:12:17 INFO - 'MAIL': '/var/mail/cltbld', 11:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:17 INFO - 'MOZ_NO_REMOTE': '1', 11:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:17 INFO - 'NO_EM_RESTART': '1', 11:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:17 INFO - 'PWD': '/builds/slave/test', 11:12:17 INFO - 'SHELL': '/bin/bash', 11:12:17 INFO - 'SHLVL': '1', 11:12:17 INFO - 'TERM': 'linux', 11:12:17 INFO - 'TMOUT': '86400', 11:12:17 INFO - 'USER': 'cltbld', 11:12:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:17 INFO - '_': '/tools/buildbot/bin/python'} 11:12:17 INFO - Requirement already satisfied: mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:17 INFO - Requirement already satisfied: mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:12:17 INFO - Requirement already satisfied: mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:12:17 INFO - Requirement already satisfied: mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:17 INFO - Requirement already satisfied: mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:12:17 INFO - Requirement already satisfied: mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:12:18 INFO - Requirement already satisfied: mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:12:18 INFO - Requirement already satisfied: mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:12:18 INFO - Requirement already satisfied: psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:12:18 INFO - Collecting simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:12:19 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/simplejson-3.3.0.tar.gz (67kB) 11:12:19 INFO - Requirement already satisfied: blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:12:19 INFO - Requirement already satisfied: moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:12:19 INFO - Installing collected packages: simplejson 11:12:19 INFO - Running setup.py install for simplejson: started 11:12:20 INFO - Running setup.py install for simplejson: finished with status 'done' 11:12:20 INFO - Successfully installed simplejson-3.3.0 11:12:20 INFO - Return code: 0 11:12:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x16091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1975a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', '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 11:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:12:20 INFO - Using env: {'DISPLAY': ':0', 11:12:20 INFO - 'HOME': '/home/cltbld', 11:12:20 INFO - 'LANG': 'en_US.UTF-8', 11:12:20 INFO - 'LANGUAGE': 'en_US:en', 11:12:20 INFO - 'LOGNAME': 'cltbld', 11:12:20 INFO - 'MAIL': '/var/mail/cltbld', 11:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:20 INFO - 'MOZ_NO_REMOTE': '1', 11:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:20 INFO - 'NO_EM_RESTART': '1', 11:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:20 INFO - 'PWD': '/builds/slave/test', 11:12:20 INFO - 'SHELL': '/bin/bash', 11:12:20 INFO - 'SHLVL': '1', 11:12:20 INFO - 'TERM': 'linux', 11:12:20 INFO - 'TMOUT': '86400', 11:12:20 INFO - 'USER': 'cltbld', 11:12:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:20 INFO - '_': '/tools/buildbot/bin/python'} 11:12:20 INFO - Requirement already satisfied: jsonschema in ./venv/lib/python2.7/site-packages 11:12:20 INFO - Requirement already satisfied: functools32; python_version == "2.7" in ./venv/lib/python2.7/site-packages (from jsonschema) 11:12:20 INFO - Return code: 0 11:12:20 INFO - Running post-action listener: _resource_record_post_action 11:12:20 INFO - Running post-action listener: _start_resource_monitoring 11:12:21 INFO - Starting resource monitoring. 11:12:21 INFO - [mozharness: 2017-09-12 18:12:21.016895Z] Finished create-virtualenv step (success) 11:12:21 INFO - [mozharness: 2017-09-12 18:12:21.017400Z] Running install step. 11:12:21 INFO - Running pre-action listener: _resource_record_pre_action 11:12:21 INFO - Running main action method: install 11:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:12:21 INFO - Reading from file tmpfile_stdout 11:12:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:12:21 INFO - Reading from file tmpfile_stdout 11:12:21 INFO - Output received: 11:12:21 INFO - Usage: mozinstall [options] installer 11:12:21 INFO - Options: 11:12:21 INFO - -h, --help show this help message and exit 11:12:21 INFO - -d DEST, --destination=DEST 11:12:21 INFO - Directory to install application into. [default: 11:12:21 INFO - "/builds/slave/test"] 11:12:21 INFO - --app=APP Application being installed. [default: firefox] 11:12:21 INFO - mkdir: /builds/slave/test/build/application 11:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:12:38 INFO - Reading from file tmpfile_stdout 11:12:38 INFO - Output received: 11:12:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - [mozharness: 2017-09-12 18:12:38.270542Z] Finished install step (success) 11:12:38 INFO - [mozharness: 2017-09-12 18:12:38.270878Z] Running setup-mitmproxy step. 11:12:38 INFO - Running pre-action listener: _resource_record_pre_action 11:12:38 INFO - Running main action method: setup_mitmproxy 11:12:38 INFO - Skipping: mitmproxy is not required 11:12:38 INFO - Running post-action listener: _resource_record_post_action 11:12:38 INFO - [mozharness: 2017-09-12 18:12:38.272553Z] Finished setup-mitmproxy step (success) 11:12:38 INFO - [mozharness: 2017-09-12 18:12:38.272860Z] Running run-tests step. 11:12:38 INFO - Running pre-action listener: _resource_record_pre_action 11:12:38 INFO - Running pre-action listener: _set_gcov_prefix 11:12:38 INFO - Running main action method: run_tests 11:12:38 WARNING - Try message not found. 11:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:12:38 INFO - Python 2.7.3 11:12:38 INFO - Return code: 0 11:12:38 INFO - grabbing minidump binary from tooltool 11:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1979090>, '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 0x1979d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1973f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:12:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:12:38 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:12:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:12:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:38 INFO - Return code: 0 11:12:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:12:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:12:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:12:38 INFO - ENV: RUST_BACKTRACE is now full 11:12:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:12:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:12:38 INFO - Using env: {'DISPLAY': ':0', 11:12:38 INFO - 'HOME': '/home/cltbld', 11:12:38 INFO - 'LANG': 'en_US.UTF-8', 11:12:38 INFO - 'LANGUAGE': 'en_US:en', 11:12:38 INFO - 'LOGNAME': 'cltbld', 11:12:38 INFO - 'MAIL': '/var/mail/cltbld', 11:12:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:38 INFO - 'MOZ_NO_REMOTE': '1', 11:12:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:38 INFO - 'NO_EM_RESTART': '1', 11:12:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:38 INFO - 'PWD': '/builds/slave/test', 11:12:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:38 INFO - 'RUST_BACKTRACE': 'full', 11:12:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:38 INFO - 'SHELL': '/bin/bash', 11:12:38 INFO - 'SHLVL': '1', 11:12:38 INFO - 'TERM': 'linux', 11:12:38 INFO - 'TMOUT': '86400', 11:12:38 INFO - 'USER': 'cltbld', 11:12:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:38 INFO - '_': '/tools/buildbot/bin/python'} 11:12:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:12:38 INFO - mozversion application_buildid: 20170912172131 11:12:38 INFO - mozversion application_changeset: 4069ad6982eabbab5b30fd45de159fe746e5a517 11:12:38 INFO - mozversion application_display_name: Nightly 11:12:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:38 INFO - mozversion application_name: Firefox 11:12:38 INFO - mozversion application_remotingname: firefox 11:12:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:12:38 INFO - mozversion application_vendor: Mozilla 11:12:38 INFO - mozversion application_version: 57.0a1 11:12:38 INFO - mozversion platform_buildid: 20170912172131 11:12:38 INFO - mozversion platform_changeset: 4069ad6982eabbab5b30fd45de159fe746e5a517 11:12:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:12:38 INFO - mozversion platform_version: 57.0a1 11:12:38 INFO - using testdate: 1505239958 11:12:38 INFO - actual date: 1505239958 11:12:38 INFO - starting webserver on 'localhost:46780' 11:12:38 INFO - SUITE-START | Running 2 tests 11:12:38 INFO - TEST-START | dromaeo_css 11:12:38 INFO - Initialising browser for dromaeo_css test... 11:12:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46780/getInfo.html -profile /tmp/tmp0OpHbt/profile 11:12:38 INFO - TEST-INFO | started process 29503 (/builds/slave/test/build/application/firefox/firefox http://localhost:46780/getInfo.html) 11:12:43 INFO - TEST-INFO | 29503: exit 0 11:12:43 INFO - Browser initialized. 11:12:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:12:43 INFO - Using env: {'DISPLAY': ':0', 11:12:43 INFO - 'HOME': '/home/cltbld', 11:12:43 INFO - 'JSGC_DISABLE_POISONING': '1', 11:12:43 INFO - 'LANG': 'en_US.UTF-8', 11:12:43 INFO - 'LANGUAGE': 'en_US:en', 11:12:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:12:43 INFO - 'LOGNAME': 'cltbld', 11:12:43 INFO - 'MAIL': '/var/mail/cltbld', 11:12:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:12:44 INFO - 'MOZ_CRASHREPORTER': '1', 11:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:12:44 INFO - 'MOZ_NO_REMOTE': '1', 11:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:44 INFO - 'NO_EM_RESTART': '1', 11:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:44 INFO - 'PWD': '/builds/slave/test', 11:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:12:44 INFO - 'RUST_BACKTRACE': 'full', 11:12:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:12:44 INFO - 'SHELL': '/bin/bash', 11:12:44 INFO - 'SHLVL': '1', 11:12:44 INFO - 'STYLO_FORCE_DISABLED': '1', 11:12:44 INFO - 'TERM': 'linux', 11:12:44 INFO - 'TMOUT': '86400', 11:12:44 INFO - 'USER': 'cltbld', 11:12:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:44 INFO - '_': '/tools/buildbot/bin/python'} 11:12:44 INFO - TEST-INFO | started process 29702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0OpHbt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:44 INFO - PID 29702 | 11:12:44 INFO - PID 29702 | (/builds/slave/test/build/application/firefox/firefox:29753): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:12:44 INFO - PID 29702 | 11:12:55 INFO - PID 29702 | RSS: Main: 170704896 11:12:55 INFO - PID 29702 | 11:15:51 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46780/tests/dromaeo/cssquery-ext.html) 11:15:52 INFO - PID 29702 | RSS: Main: 171294720 11:15:52 INFO - PID 29702 | 11:18:54 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-ext.html (next: http://localhost:46780/tests/dromaeo/cssquery-jquery.html) 11:18:55 INFO - PID 29702 | RSS: Main: 169119744 11:18:55 INFO - PID 29702 | 11:21:56 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46780/tests/dromaeo/cssquery-mootools.html) 11:21:57 INFO - PID 29702 | RSS: Main: 170151936 11:21:57 INFO - PID 29702 | 11:24:59 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46780/tests/dromaeo/cssquery-prototype.html) 11:24:59 INFO - PID 29702 | RSS: Main: 168714240 11:24:59 INFO - PID 29702 | 11:28:02 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46780/tests/dromaeo/cssquery-yui.html) 11:28:03 INFO - PID 29702 | RSS: Main: 171270144 11:28:03 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | Cycle 1(1): loaded http://localhost:46780/tests/dromaeo/cssquery-yui.html (next: http://localhost:46780/tests/dromaeo/cssquery-dojo.html) 11:31:05 INFO - PID 29702 | RSS: Main: 174383104 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | __start_tp_report 11:31:05 INFO - PID 29702 | _x_x_mozilla_page_load 11:31:05 INFO - PID 29702 | _x_x_mozilla_page_load_details 11:31:05 INFO - PID 29702 | |i|pagename|runs| 11:31:05 INFO - PID 29702 | |0;dojo.html;3131.295458521833;3152.763542734294;3158.8578513966863;3167.255694911695;3178.1895616617758;6040.577159598819;6227.097070924713;6241.282252540954;6286.591371560851;6364.14084098646;6140.877182456359;6176.75292988281;6197.814065578029;6201.317855035943;6201.782937597185;5716.114002329635;5722.856928576798;5813.534917206634;5814.186013958049;5820.767169313243;5816.651000939957;5856.297244330686;5858.8242352729485;5871.3541510433815;5886.205362276102;33.88843752579651;5680.602357834932;5683.090705487102;5850.502707269887;5881.558883083764;5773.711314434261;5786.392428795;5852.092925596497;5852.326982397036;5857.707114644293;5756.942430575683;5775.509081728058;5824.767009319622;5838.2118414013985;5847.502962248214;6279.811605651837;6294.7482100715915;6299.716512756937;6362.713677884506;6383.106365108889;6688.297728738461;6726.865462690767;6794.76218332356;6805.523613347068;6814.557053791487;6578.572392794501;6687.598744075371;6697.464202863759;6714.026466162379;6782.593044417302;6169.7532098716;6207.596506227081;6233.625982441068;6314.684265786738;6342.460890824285;6899.551529150589;6985.615791131435;6987.196472405739;6987.6855541500245;6991.580505169706;6586.473082153416;6590.472762179014;6610.0745895574655;6681.899771503431;6683.064370988066;6544.247411547733;6657.633830139292;6661.766838160738;6758.695858686371;6784.151981002375;6707.5304728668525;6718.596884186964;6725.495587830835;6736.629485378351;6763.864722705518;6698.229703584053;6732.798016059526;6747.156605424322;6822.624755638488;6830.93169068303;5074.162763144113;5271.393789714155;5314.92027619586;5335.146376579729;5340.759665815048;4536.523665015192;4578.793954272066;4616.469106052847;4654.045920586272;4666.580007799314;5800.274965629296;5850.151727999501;5870.44230798082;5871.236739223874;5876.559258055663;6736.05695202672;6772.288909664513;6785.084013658192;6848.760293389708;6858.759943402057;5708.1723150143;5774.364819869811;5793.2179155814265;5797.710114494343;5814.476697097197;5777.768889244383;5829.854253643693;5846.590738648339;5852.561057920588;5861.794837180763;6351.745930162834;6416.518761092937;6430.356964303533;6548.541602087808;6628.337166283333;6581.670916454158;6590.901136483052;6594.241662208908;6597.80206593803;6598.94416893314;6393.904091438539;6413.454856337264;6486.643234622141;6575.835604109744;6611.2727599963;6566.146400967844;6671.39957403836;6696.196456425066;6731.427828634621;6760.053592496956;6791;6795.660216989032;6847.383735463832;6876.449884009167;6878.140232470942;6324.494040476843;6447.161868957006;6491.805245842632;6564.5076619254705;6568.80293591193;6582.440492558187;6610.867782644416;6617.139771829631;6618.404343609098;6630.701618427086;6448.065030570635;6457.5479716419395;6466.256380516301;6544.705488253136;6545.116409284686;6555.80332590023;6572.277049524644;6612.50406219545;6662.333766623299;6668.499862510234;6210.347913469021;6253.812385628438;6280.497560195265;6328.367163283635;6365.2361716594305 11:31:05 INFO - PID 29702 | |1;ext.html;841.1924552429667;844.4089137603679;855.5551113421021;882.7131182365732;888.3248730964465;41622.16755664892;41842.37236441456;42067.57932420675;42858.78570607147;42865.78567107164;42967.35548966768;43274.350884736676;43341.7832910835;43375.78312108443;43403.78298108505;7645.923540764591;7770.145284018753;7776;7777.766666999999;7786.3381612563;7638.809029774272;7705.8844117338285;7710.57591832449;7720.034995625547;7732.7680169595005;7742.14836367999;7779.377649788032;7789.260020298063;7791.883121753178;7793.415493837956;7737.187595302468;7764.951731516229;7768.57272849993;7768.611569421506;7768.650410731474;7658.73194438192;7728.343090837286;7738.496997695188;7757.4181936354435;7760.223977602251;38476;38610.22779544422;38741.22517549633;38811.8059409704;38886.41670374947;3468.618451970281;3514.7715398499017;3516.753827232095;3520.102373894666;3528.964710352889;32193.51709724356;32256.35487290241;32262.516062259085;32269.193270168198;32292;4987.102321582114;5120.820771273025;5168.8449346519665;5176.922346164811;5184.326037615124;187153;187641.06179469152;187784;188085;189018;48081;48245.75877120592;48344.75827620839;48363.51636483661;48457.273140902915;50251.497485025415;50317.496825032016;50357.49642503528;50504;50573.24140137901;13734.381952812148;13796.448142074205;13963.441462341392;13964.441422342992;13965.092269002482;11171.608993685344;11206.551737930391;11208.215424920178;11218.439078046065;11226.887731122748;13051.694830517063;13216.603501894959;13238.602841914759;13267.402966866513;13387.933060334635;5124.285657195314;5130.30740849988;5186.507281808223;5211.1922651989;5234.895302093937;977.941323520591;996.14829320931;1002.5638847101388;1021.5862575656871;1026.7535791410007;22052.11791528321;22195.22316718907;22294.55410891773;22482.32553023412;22513.099476020776;1080.065743132185;1089.9509522071526;1097.1223021582862;1101.2016288190998;1104.9005589496824;11918.523259069714;11927;11941.582044628396;11972.64082077539;12063.276203427822;202723;202912;203660;224993;229304;55637.721811390686;55891.44108558862;56037.439625604035;56080.43919560752;56196;1401.5935378740255;1404.8524904885044;1407.134612213502;1410.499272758197;1429.428228708525;26558.86720566385;26647;26871.696491911276;27205.455890882466;27247.45505089927;37761.62238377581;37853.053673657276;37872.81063594665;37887.62112378841;37912.62087379091;188458;190038;190171;191093.04453477645;191274;33795;33840.83079584586;33905.83047084749;33931.83034084814;34005.65994340025;41903.7904810474;43359.566404336816;43541;43655.34516982184;43861.342079869464;31441.685583143877;31539.211519711273;31629.36741265208;31634.841825790725;32055.198620034687;31290.530642039932;31615.36769264648;31876.5218521727;31888.36223275475;32131.19672008125;34818.65181348154;35751.82124089467;35937.28125437529;36031;36194.819025904704;31480.527792083594;31508;31741.365172695954;31775.6822431782;31811.840940795148;22946.42633934165;23088.53822923566;23160.619948920714;23381.76618233796;23555.41111472227 11:31:05 INFO - PID 29702 | |2;jquery.html;567.8321122957494;571.8370264474626;572.3246569048522;582.2983305117334;584.1179818474104;21874.562508749834;22603.208887688954;22649.433764155903;22807.201747938827;22819.77180228197;23338.64992025121;24433.144839930606;24733.134340298093;24783.132590359295;24822.379440513996;6436.742530298782;6622.470202383822;6627.701753421084;6631.900521492182;6634.104395906539;6338.841528961767;6496.317886621884;6566.901496477557;6592.604443733391;6599.6370199639005;6544.018397240405;6545.9018114728315;6546.574472659262;6546.574472659286;6554.8689026219445;6524;6524.706388212542;6524.804255872307;6526.54314198004;6550.8034758957065;6690.698918548628;6993.580385176906;6994.5803251805055;6998.405135563483;7002;29644.70355296441;30302.545461818092;30308.8484557578;30310.242243943856;30317.393652127055;2006.388051644248;2033.2273735980382;2037.0425899827057;2037.4091513461078;2037.9796202037937;19788.604227915504;20028.69956950647;20369.5926081479;20940;21068.26261080855;2497.4880149569294;2504.8622325772258;2559.6160575913577;2580.7548282913094;2586.521493523704;117370;123883.38058309742;124157;136031.31984340015;142944;19769.40691779249;20746;21154.365369038955;21261.830599316876;21390.358289251035;41426;41568.96077598084;41594.58405415968;41656.79171604183;41697.37453938193;9583.472908990072;9725.854112188323;9775.804483910282;9854.852177217204;9929.3545919515;7814.296713295831;7854.567998760009;7872.772952264897;7933.286004259644;7946.125926148119;10682.679519614425;10923.672289831318;11023.503942322615;11244;11269.887301126884;3908.55051669056;4056.716029877939;4233.534311225762;4314.805833737427;4387.4954380246045;928.122923836981;954.5942974235921;957.6696039866235;971.1502435369052;976.3897564022486;18574.721379179322;18707.71938420925;18728.1907713844;18774.436766897015;18807.15367808452;986.7779749556292;1009.5255230041869;1011.0698157694939;1024.4314405505015;1028.0695970147028;10286.948565257275;10353;10401.27191096616;10404.375737455777;10719.517621707042;432578;446126;446129;450161;456171;109417;110009;112197;112947.43526282316;114044;1018.8828284747201;1068.71144790906;1134.7163209197702;1135.795556799784;1177.8822117788152;18789.248430062646;19391.903040484707;19505;19529;19730.112144953226;56459.71770141123;56599.71700141473;56800;57129;57877.71061144667;67314.66342668256;70077.64961175162;70257.64871175612;70570.29429705637;70663.64668176626;19105.140268687665;19167.712484313026;19296.517587060436;19403.8059619402;19508.21967121356;21962;21986.780132199114;22018;22153.77846221517;22338.66492002654;17628.29486820513;17742.29030838752;17766.555836103682;17829;17963.101844907964;15519.5344139676;16133.112678802778;16317.59206019859;16326.428574999818;16387.75418368749;15683.1374274416;17780.46658600244;17914.193861276013;18336.816631834045;18559.25762969466;18950.715739263647;19067;19095.14071866797;19126.904365478083;19456.805431946064;17334.219960101575;17426.390076347267;17666.5583360417;17758.37845675395;17782.110894454967 11:31:05 INFO - PID 29702 | |3;mootools.html;1214.1318956945781;1253.7805883970302;1254.843144606924;1261.2558590431643;1264.772340978624;14547.927260363696;15195.772063419057;15204.543863684094;15217.16305603194;15228.923855380708;14858.925705371457;14995.325210365532;15006.099634021966;15020.624484387896;15020.924895375509;2728.249731323882;2731.8224315419484;2785.679646840619;2785.7214278572183;2789.3584475570633;2689.247010836959;2728.01791355112;2736.3979924416694;2762.709915458878;2765.5436852919242;2655.5618322976684;2706.120510833977;2742.602322663213;2746.7939904507143;2757.076379412899;2716.7962402819767;2739.561670132769;2783.6520434945633;2784.3874347643587;2786.1084452975056;2615.3592369869502;2743.684476285233;2798.2864369585827;2807.396409771909;2809.12916995732;14953.551393458105;15020.248987550687;15086;15093.169875656835;15100.924495377563;7568.5458872467825;7846.882296765553;7896.170902055259;7900.881486777703;7910.248526389983;5135.204043373283;5159.819406320798;5221.373435187764;5271.604629652791;5302.231176479428;1937.9127939242767;1942.2328180368675;1957.5889063296725;2000.249906285143;2008.5681578460556;25584.74415255842;25714.48571028569;26308;26384.340391490365;26927.730722692522;7170.6056166910275;7201.13586369639;7281.308275713799;7365.852682946311;7416.7774966751085;20012.099455524538;20037.098330575158;20048.198072076953;20093.99060094008;20127.194912203642;7886.9211307887335;7965.402594805413;7980.680772769024;7983.560904150211;7997.200279971957;7031.261717519689;7114.217436082027;7160.928390716131;7173.246809085075;7221.855562888818;5593;5705.71471426427;5752.108423194411;5753.223314852441;5940.554458415636;1633.3956436118474;1664.142966372295;1712.7859017622798;1775.1213149491084;1833.844123249512;839.2740279658052;854.1842540374053;857.7855536115972;862.6333808131519;879.134052957836;8204.441156180306;8225.506469611842;8385.916140838513;8393.370497212734;8445.704400345958;888.8445519614908;922;950.4059962523423;953.02315126994;964.5273815830193;5014;5098.311727916758;5133.563647089964;5180;5207.557357624644;21031.57936841285;22078.448038799157;22161;22180.778192218193;22210.222642207445;20572.691409628867;21578.352649420227;21601.567968640855;21628.675569866464;21779.564408711736;10401.94799026;10523;10529.789404212026;10624.787504250025;10644.148468122532;8128.87806682912;8232.765085237263;8266.380021498531;8380.287675547646;8422.873656895274;18212.271509139486;18552.072396380398;18604;18700.158492868126;18960.810391895906;18611.255549777856;18822.6235475287;18851.528711781768;18867.716984244973;18937.33719319817;11734.823977640172;11956.521739130685;11965.222260553037;12099;12110.970567501861;13526;13579.728405432033;13599.456021759019;13672.726545469233;13719.725605487634;11143.442827858737;11246.268992515461;11246.83129753038;11359.54561817518;11561.537538498365;10680.62617808373;10816.837747433952;10820;10989.670309890716;11066.39134847591;9541.856872147062;9736.41581505112;9788.168005719308;9816.361936474392;9835.311528192959;6851.246362899978;6884.311568843075;6958.826029349307;6966.12923384577;6992.965035174791;6842.418394436529;6918.204406493318;6923;7001.229864714979;7044.15470143586 11:31:05 INFO - PID 29702 | |4;prototype.html;498.59769398566516;500.6682225280754;520.398939225195;526.108246522145;529.3409704917378;6187.4740647045;6241.126242326078;6246.500279977602;6298.464630506407;6322.450999505116;6140.508759299257;6212.471939885115;6214.316425193237;6228.22147231596;6243.875122497559;5177.767000484969;5188.247704082905;5194.63637545372;5195.636305458619;5227;4777.426708794949;5098.107831129556;5100.260462232974;5170.715610641413;5181.585473162157;4900.558949694527;4920.950790492103;4930.7534623268875;4933.925991110136;4950.504949505057;4901.8774530636665;4910.803567857281;4924.138275801738;4926.187179115442;4945.35710357653;4423.225935461282;4423.270160423526;4735.976320118378;4783.808647654089;4812.542808433193;6064.484518815906;6069.817905462844;6074.48366888815;6075.848103797396;6084.878302433971;5901.616394934315;5933.762649494015;5940.198073260098;5949.970250148722;5991.3109992351;6510.772122975721;6551.508636852255;6565.785329714018;6604.8348791280605;6637.369449902251;4954.504549545017;5215.973920130413;5261;5271.499207575274;5277.815276465305;6712.731490740413;6741.696623651947;6798.966005169992;6802.591844489347;6832.385085342294;5393.2179833923865;5398.514133727984;5398.568114550826;5398.811041613603;5434.91847622286;5439.374471935699;5482.095454250004;5510.724463776795;5520.227168196456;5523.337199536081;5922.674252916131;5934.198883150806;5967.5524335675;5974.940250597525;5977.760889564369;6428.678566071678;6481.740730370827;6535.379138981789;6618.238902526175;6625.469962402996;1871.7739880378374;1880.3042874136656;1883.3784850999136;1885.2270569066616;1910.3027395000724;1362.209918247434;1416.3060100550863;1418.7517184492672;1432.3268064009899;1434.0678558936775;5530.917036244459;5531.861703457445;5549;5613.214150019001;5644.57665675076;6478.740850366027;6593.142891424084;6602.7028783704845;6658.500612454085;6703.195616526048;5596.832095037155;5622.32532096151;5623.662580245198;5701.800436984686;5704.543636509069;3420.1620602952435;3477.14809871578;3480.373532764076;3531.2407832316176;3558.1104723819044;6419.935800642027;6429.453496452854;6477.611343319416;6478.222613286436;6493.155889734304;6700.631465269359;6751.628660423626;6774.83062923421;6779.2881747416795;6875.5530890491955;6335.049742538656;6389.552731308764;6404.398900274931;6431.517636177306;6456.9668852983295;6579.243387010555;6581.012848072636;6591.143151390289;6651.102101216274;6683.8997415039785;6548.672566371758;6552.410283074546;6576.408123268929;6613.404793568602;6634.601923884582;6267.780627678009;6336.619802811846;6375.139356186855;6409.551331406757;6417.358264173546;4832.903341933212;4877.951220487892;4899.877503062452;4904.803807847647;4922.92615610759;6341.841453963688;6466.579672321284;6504.479641628753;6631.602103873783;6641.601503909781;6251.78118765841;6382.5532212744665;6396.648184349905;6402.167718196604;6463.741450341934;6232.345603711727;6277.435030847063;6382.648954307558;6384.3934826191435;6385.808425747235;6039.396060393926;6217.191765070512;6223.408776166257;6233.314335423009;6347.841303967438;6311.684415779101;6471.191101112361;6487.021458455028;6513.706883190173;6574.638394888327;6244.625322480666;6293.465055470337;6311.779087731908;6324.1146239527425;6346.6037471756135 11:31:05 INFO - PID 29702 | |5;yui.html;872.7948932000975;898.4923518212214;900.1223806788381;902.7878448564586;915.5330781301536;18872.433826985194;19750.70373944392;19851.801481985174;19868.006599670032;19940.900295498537;16987.83012169878;17104;17180.484585462455;17246.31014759411;17511.562210944732;943.5423819447562;944.584382871536;945.9479728614923;949.2311227905384;951.1344676344528;944.2210176604294;944.4522177137278;946.2288235088415;950.6720181537393;967.2552134856156;1021.9284650074461;1032.1587905856702;1032.4682788363998;1032.9225308101884;1033.0392734756674;1022;1022.0290723812408;1022.5551884930042;1023.0281232828843;1024.0732137415614;716.3481232078783;734.9154847192588;740.28932225064;740.6000759589815;742.2985278911431;19953.800461995485;20139.6979045313;20212.595748084957;20231.190752369886;20259.696104558443;20920.37238882836;20937.26719564823;21490.78509214919;21604;21621.67567486489;15981.760273595906;16245.268962896698;16301.51095467138;16355.182240887909;16446.75329870053;3758.4550240215017;3784.924301513982;3792.886213413602;3794.677452416548;3803.6386543278345;130866;136665;138479;138819.30590347084;141070.2946485261;16711;16803.579910502336;16985.660286794442;17029.57426064358;17055.317787288368;29603.851980739957;29664.851675741484;29787.85106074499;29801;29802.10593682193;8438.789030274169;8500.787480313042;8501.574921253912;8502.829943401097;8533.74398768038;3850.845966161322;3869.1487872667967;3889.4749208857006;3892.9805350973065;3895.6104389561383;4717.127331443694;5069.087564238399;5085.059264036166;5096.159133742965;5126.7180305083575;968.5689868008668;968.9273304502191;990.2028866762325;994.0506815990711;994.4530508220449;662.4336192555392;684.5687217053224;692.1693967239333;697.9651017449208;703.0930100170825;11302.886971130349;11385.203035787416;11835.822462663067;11956.282623042645;12192.512299508098;604.8125081224835;608.7564974010431;608.9269287685506;614.241411856357;635.1489004733679;5629;5650.463205995424;5705.800296989585;5723.998300297431;5728.684922329228;124037;125274.98900043896;126384.2248340932;128598.35700821436;129424.352878235;107309;107518.46240768746;107815.46092269488;109548.4522577398;114604.42697786458;94110.52944735232;95635;96101.51949240209;97317;97600.51199743956;9985.950070249894;10128.531362952182;10443.216758742972;10459.790804183722;10461.372317660966;42521.36217956795;43532;44038;44048.339274910264;44127.33808992804;56953.71523142358;57659.4234057654;58020;58882.41117588769;59076;14251.144931304156;14323.928380358031;14334.856651433352;14498.927505362406;14498.927505362406;16214.027158370536;16338.836611634208;16428.42500512476;16530.421435249707;16566.088865112535;15456.304466298818;15514.9224253878;15593.610159746097;15723.842761572238;15742.449014284444;12233.143679942319;12323.198992065487;12345.753084938071;12375;12375.443105060474;13467.932660336635;13589.932050339685;13596.456141754219;13684;13752.243626600233;11863.288202707865;12007.339596321937;12008.39958002114;12046;12049.518019279481;11090.16823738239;11228.10175185967;11282.702489213845;11305.604303849326;11516.078713703051 11:31:05 INFO - PID 29702 | __end_tp_report 11:31:05 INFO - PID 29702 | __start_cc_report 11:31:05 INFO - PID 29702 | _x_x_mozilla_cycle_collect,356 11:31:05 INFO - PID 29702 | __end_cc_report 11:31:05 INFO - PID 29702 | __startTimestamp1505241065332__endTimestamp 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | ------- Summary: start ------- 11:31:05 INFO - PID 29702 | Number of tests: 6 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#0] dojo.html Cycles:165 Average:6151.44 Median:6393.90 stddev:881.37 (13.8%) stddev-sans-first:851.63 11:31:05 INFO - PID 29702 | Values: 3131.3 3152.8 3158.9 3167.3 3178.2 6040.6 6227.1 6241.3 6286.6 6364.1 6140.9 6176.8 6197.8 6201.3 6201.8 5716.1 5722.9 5813.5 5814.2 5820.8 5816.7 5856.3 5858.8 5871.4 5886.2 33.9 5680.6 5683.1 5850.5 5881.6 5773.7 5786.4 5852.1 5852.3 5857.7 5756.9 5775.5 5824.8 5838.2 5847.5 6279.8 6294.7 6299.7 6362.7 6383.1 6688.3 6726.9 6794.8 6805.5 6814.6 6578.6 6687.6 6697.5 6714.0 6782.6 6169.8 6207.6 6233.6 6314.7 6342.5 6899.6 6985.6 6987.2 6987.7 6991.6 6586.5 6590.5 6610.1 6681.9 6683.1 6544.2 6657.6 6661.8 6758.7 6784.2 6707.5 6718.6 6725.5 6736.6 6763.9 6698.2 6732.8 6747.2 6822.6 6830.9 5074.2 5271.4 5314.9 5335.1 5340.8 4536.5 4578.8 4616.5 4654.0 4666.6 5800.3 5850.2 5870.4 5871.2 5876.6 6736.1 6772.3 6785.1 6848.8 6858.8 5708.2 5774.4 5793.2 5797.7 5814.5 5777.8 5829.9 5846.6 5852.6 5861.8 6351.7 6416.5 6430.4 6548.5 6628.3 6581.7 6590.9 6594.2 6597.8 6598.9 6393.9 6413.5 6486.6 6575.8 6611.3 6566.1 6671.4 6696.2 6731.4 6760.1 6791.0 6795.7 6847.4 6876.4 6878.1 6324.5 6447.2 6491.8 6564.5 6568.8 6582.4 6610.9 6617.1 6618.4 6630.7 6448.1 6457.5 6466.3 6544.7 6545.1 6555.8 6572.3 6612.5 6662.3 6668.5 6210.3 6253.8 6280.5 6328.4 6365.2 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#1] ext.html Cycles:180 Average:36874.99 Median:3515.76 stddev:51147.38 (1454.8%) stddev-sans-first:51219.30 11:31:05 INFO - PID 29702 | Values: 841.2 844.4 855.6 882.7 888.3 41622.2 41842.4 42067.6 42858.8 42865.8 42967.4 43274.4 43341.8 43375.8 43403.8 7645.9 7770.1 7776.0 7777.8 7786.3 7638.8 7705.9 7710.6 7720.0 7732.8 7742.1 7779.4 7789.3 7791.9 7793.4 7737.2 7765.0 7768.6 7768.6 7768.7 7658.7 7728.3 7738.5 7757.4 7760.2 38476.0 38610.2 38741.2 38811.8 38886.4 3468.6 3514.8 3516.8 3520.1 3529.0 32193.5 32256.4 32262.5 32269.2 32292.0 4987.1 5120.8 5168.8 5176.9 5184.3 187153.0 187641.1 187784.0 188085.0 189018.0 48081.0 48245.8 48344.8 48363.5 48457.3 50251.5 50317.5 50357.5 50504.0 50573.2 13734.4 13796.4 13963.4 13964.4 13965.1 11171.6 11206.6 11208.2 11218.4 11226.9 13051.7 13216.6 13238.6 13267.4 13387.9 5124.3 5130.3 5186.5 5211.2 5234.9 977.9 996.1 1002.6 1021.6 1026.8 22052.1 22195.2 22294.6 22482.3 22513.1 1080.1 1090.0 1097.1 1101.2 1104.9 11918.5 11927.0 11941.6 11972.6 12063.3 202723.0 202912.0 203660.0 224993.0 229304.0 55637.7 55891.4 56037.4 56080.4 56196.0 1401.6 1404.9 1407.1 1410.5 1429.4 26558.9 26647.0 26871.7 27205.5 27247.5 37761.6 37853.1 37872.8 37887.6 37912.6 188458.0 190038.0 190171.0 191093.0 191274.0 33795.0 33840.8 33905.8 33931.8 34005.7 41903.8 43359.6 43541.0 43655.3 43861.3 31441.7 31539.2 31629.4 31634.8 32055.2 31290.5 31615.4 31876.5 31888.4 32131.2 34818.7 35751.8 35937.3 36031.0 36194.8 31480.5 31508.0 31741.4 31775.7 31811.8 22946.4 23088.5 23160.6 23381.8 23555.4 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#2] jquery.html Cycles:180 Average:34057.85 Median:22626.32 stddev:75323.18 (332.9%) stddev-sans-first:75492.51 11:31:05 INFO - PID 29702 | Values: 567.8 571.8 572.3 582.3 584.1 21874.6 22603.2 22649.4 22807.2 22819.8 23338.6 24433.1 24733.1 24783.1 24822.4 6436.7 6622.5 6627.7 6631.9 6634.1 6338.8 6496.3 6566.9 6592.6 6599.6 6544.0 6545.9 6546.6 6546.6 6554.9 6524.0 6524.7 6524.8 6526.5 6550.8 6690.7 6993.6 6994.6 6998.4 7002.0 29644.7 30302.5 30308.8 30310.2 30317.4 2006.4 2033.2 2037.0 2037.4 2038.0 19788.6 20028.7 20369.6 20940.0 21068.3 2497.5 2504.9 2559.6 2580.8 2586.5 117370.0 123883.4 124157.0 136031.3 142944.0 19769.4 20746.0 21154.4 21261.8 21390.4 41426.0 41569.0 41594.6 41656.8 41697.4 9583.5 9725.9 9775.8 9854.9 9929.4 7814.3 7854.6 7872.8 7933.3 7946.1 10682.7 10923.7 11023.5 11244.0 11269.9 3908.6 4056.7 4233.5 4314.8 4387.5 928.1 954.6 957.7 971.2 976.4 18574.7 18707.7 18728.2 18774.4 18807.2 986.8 1009.5 1011.1 1024.4 1028.1 10286.9 10353.0 10401.3 10404.4 10719.5 432578.0 446126.0 446129.0 450161.0 456171.0 109417.0 110009.0 112197.0 112947.4 114044.0 1018.9 1068.7 1134.7 1135.8 1177.9 18789.2 19391.9 19505.0 19529.0 19730.1 56459.7 56599.7 56800.0 57129.0 57877.7 67314.7 70077.6 70257.6 70570.3 70663.6 19105.1 19167.7 19296.5 19403.8 19508.2 21962.0 21986.8 22018.0 22153.8 22338.7 17628.3 17742.3 17766.6 17829.0 17963.1 15519.5 16133.1 16317.6 16326.4 16387.8 15683.1 17780.5 17914.2 18336.8 18559.3 18950.7 19067.0 19095.1 19126.9 19456.8 17334.2 17426.4 17666.6 17758.4 17782.1 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#3] mootools.html Cycles:180 Average:9374.78 Median:2728.13 stddev:6732.65 (246.8%) stddev-sans-first:6723.62 11:31:05 INFO - PID 29702 | Values: 1214.1 1253.8 1254.8 1261.3 1264.8 14547.9 15195.8 15204.5 15217.2 15228.9 14858.9 14995.3 15006.1 15020.6 15020.9 2728.2 2731.8 2785.7 2785.7 2789.4 2689.2 2728.0 2736.4 2762.7 2765.5 2655.6 2706.1 2742.6 2746.8 2757.1 2716.8 2739.6 2783.7 2784.4 2786.1 2615.4 2743.7 2798.3 2807.4 2809.1 14953.6 15020.2 15086.0 15093.2 15100.9 7568.5 7846.9 7896.2 7900.9 7910.2 5135.2 5159.8 5221.4 5271.6 5302.2 1937.9 1942.2 1957.6 2000.2 2008.6 25584.7 25714.5 26308.0 26384.3 26927.7 7170.6 7201.1 7281.3 7365.9 7416.8 20012.1 20037.1 20048.2 20094.0 20127.2 7886.9 7965.4 7980.7 7983.6 7997.2 7031.3 7114.2 7160.9 7173.2 7221.9 5593.0 5705.7 5752.1 5753.2 5940.6 1633.4 1664.1 1712.8 1775.1 1833.8 839.3 854.2 857.8 862.6 879.1 8204.4 8225.5 8385.9 8393.4 8445.7 888.8 922.0 950.4 953.0 964.5 5014.0 5098.3 5133.6 5180.0 5207.6 21031.6 22078.4 22161.0 22180.8 22210.2 20572.7 21578.4 21601.6 21628.7 21779.6 10401.9 10523.0 10529.8 10624.8 10644.1 8128.9 8232.8 8266.4 8380.3 8422.9 18212.3 18552.1 18604.0 18700.2 18960.8 18611.3 18822.6 18851.5 18867.7 18937.3 11734.8 11956.5 11965.2 12099.0 12111.0 13526.0 13579.7 13599.5 13672.7 13719.7 11143.4 11246.3 11246.8 11359.5 11561.5 10680.6 10816.8 10820.0 10989.7 11066.4 9541.9 9736.4 9788.2 9816.4 9835.3 6851.2 6884.3 6958.8 6966.1 6993.0 6842.4 6918.2 6923.0 7001.2 7044.2 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#4] prototype.html Cycles:180 Average:5517.19 Median:6112.69 stddev:1485.58 (24.3%) stddev-sans-first:1441.20 11:31:05 INFO - PID 29702 | Values: 498.6 500.7 520.4 526.1 529.3 6187.5 6241.1 6246.5 6298.5 6322.5 6140.5 6212.5 6214.3 6228.2 6243.9 5177.8 5188.2 5194.6 5195.6 5227.0 4777.4 5098.1 5100.3 5170.7 5181.6 4900.6 4921.0 4930.8 4933.9 4950.5 4901.9 4910.8 4924.1 4926.2 4945.4 4423.2 4423.3 4736.0 4783.8 4812.5 6064.5 6069.8 6074.5 6075.8 6084.9 5901.6 5933.8 5940.2 5950.0 5991.3 6510.8 6551.5 6565.8 6604.8 6637.4 4954.5 5216.0 5261.0 5271.5 5277.8 6712.7 6741.7 6799.0 6802.6 6832.4 5393.2 5398.5 5398.6 5398.8 5434.9 5439.4 5482.1 5510.7 5520.2 5523.3 5922.7 5934.2 5967.6 5974.9 5977.8 6428.7 6481.7 6535.4 6618.2 6625.5 1871.8 1880.3 1883.4 1885.2 1910.3 1362.2 1416.3 1418.8 1432.3 1434.1 5530.9 5531.9 5549.0 5613.2 5644.6 6478.7 6593.1 6602.7 6658.5 6703.2 5596.8 5622.3 5623.7 5701.8 5704.5 3420.2 3477.1 3480.4 3531.2 3558.1 6419.9 6429.5 6477.6 6478.2 6493.2 6700.6 6751.6 6774.8 6779.3 6875.6 6335.0 6389.6 6404.4 6431.5 6457.0 6579.2 6581.0 6591.1 6651.1 6683.9 6548.7 6552.4 6576.4 6613.4 6634.6 6267.8 6336.6 6375.1 6409.6 6417.4 4832.9 4878.0 4899.9 4904.8 4922.9 6341.8 6466.6 6504.5 6631.6 6641.6 6251.8 6382.6 6396.6 6402.2 6463.7 6232.3 6277.4 6382.6 6384.4 6385.8 6039.4 6217.2 6223.4 6233.3 6347.8 6311.7 6471.2 6487.0 6513.7 6574.6 6244.6 6293.5 6311.8 6324.1 6346.6 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | [#5] yui.html Cycles:180 Average:24023.86 Median:20176.15 stddev:35586.17 (176.4%) stddev-sans-first:35643.54 11:31:05 INFO - PID 29702 | Values: 872.8 898.5 900.1 902.8 915.5 18872.4 19750.7 19851.8 19868.0 19940.9 16987.8 17104.0 17180.5 17246.3 17511.6 943.5 944.6 945.9 949.2 951.1 944.2 944.5 946.2 950.7 967.3 1021.9 1032.2 1032.5 1032.9 1033.0 1022.0 1022.0 1022.6 1023.0 1024.1 716.3 734.9 740.3 740.6 742.3 19953.8 20139.7 20212.6 20231.2 20259.7 20920.4 20937.3 21490.8 21604.0 21621.7 15981.8 16245.3 16301.5 16355.2 16446.8 3758.5 3784.9 3792.9 3794.7 3803.6 130866.0 136665.0 138479.0 138819.3 141070.3 16711.0 16803.6 16985.7 17029.6 17055.3 29603.9 29664.9 29787.9 29801.0 29802.1 8438.8 8500.8 8501.6 8502.8 8533.7 3850.8 3869.1 3889.5 3893.0 3895.6 4717.1 5069.1 5085.1 5096.2 5126.7 968.6 968.9 990.2 994.1 994.5 662.4 684.6 692.2 698.0 703.1 11302.9 11385.2 11835.8 11956.3 12192.5 604.8 608.8 608.9 614.2 635.1 5629.0 5650.5 5705.8 5724.0 5728.7 124037.0 125275.0 126384.2 128598.4 129424.4 107309.0 107518.5 107815.5 109548.5 114604.4 94110.5 95635.0 96101.5 97317.0 97600.5 9986.0 10128.5 10443.2 10459.8 10461.4 42521.4 43532.0 44038.0 44048.3 44127.3 56953.7 57659.4 58020.0 58882.4 59076.0 14251.1 14323.9 14334.9 14498.9 14498.9 16214.0 16338.8 16428.4 16530.4 16566.1 15456.3 15514.9 15593.6 15723.8 15742.4 12233.1 12323.2 12345.8 12375.0 12375.4 13467.9 13589.9 13596.5 13684.0 13752.2 11863.3 12007.3 12008.4 12046.0 12049.5 11090.2 11228.1 11282.7 11305.6 11516.1 11:31:05 INFO - PID 29702 | -------- Summary: end -------- 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | 11:31:05 INFO - PID 29702 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 11:31:05 INFO - PID 29702 | 11:31:06 INFO - TEST-INFO | 29702: exit 0 11:31:06 INFO - TEST-OK | dromaeo_css | took 1107483ms 11:31:06 INFO - TEST-START | kraken 11:31:06 INFO - Initialising browser for kraken test... 11:31:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46780/getInfo.html -profile /tmp/tmpzIE8OU/profile 11:31:06 INFO - TEST-INFO | started process 30082 (/builds/slave/test/build/application/firefox/firefox http://localhost:46780/getInfo.html) 11:31:10 INFO - TEST-INFO | 30082: exit 0 11:31:11 INFO - Browser initialized. 11:31:11 INFO - Running cycle 1/1 for kraken test... 11:31:11 INFO - Using env: {'DISPLAY': ':0', 11:31:11 INFO - 'HOME': '/home/cltbld', 11:31:11 INFO - 'JSGC_DISABLE_POISONING': '1', 11:31:11 INFO - 'LANG': 'en_US.UTF-8', 11:31:11 INFO - 'LANGUAGE': 'en_US:en', 11:31:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:31:11 INFO - 'LOGNAME': 'cltbld', 11:31:11 INFO - 'MAIL': '/var/mail/cltbld', 11:31:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:11 INFO - 'MOZ_CRASHREPORTER': '1', 11:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:31:11 INFO - 'MOZ_NO_REMOTE': '1', 11:31:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:11 INFO - 'NO_EM_RESTART': '1', 11:31:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:11 INFO - 'PWD': '/builds/slave/test', 11:31:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:11 INFO - 'RUST_BACKTRACE': 'full', 11:31:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:31:11 INFO - 'SHELL': '/bin/bash', 11:31:11 INFO - 'SHLVL': '1', 11:31:11 INFO - 'STYLO_FORCE_DISABLED': '1', 11:31:11 INFO - 'TERM': 'linux', 11:31:11 INFO - 'TMOUT': '86400', 11:31:11 INFO - 'USER': 'cltbld', 11:31:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458', 11:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:11 INFO - '_': '/tools/buildbot/bin/python'} 11:31:11 INFO - TEST-INFO | started process 30282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzIE8OU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:12 INFO - PID 30282 | 11:31:12 INFO - PID 30282 | (/builds/slave/test/build/application/firefox/firefox:30333): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:31:12 INFO - PID 30282 | 11:31:22 INFO - PID 30282 | RSS: Main: 170717184 11:31:22 INFO - PID 30282 | 11:31:25 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46780/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:26 INFO - PID 30282 | RSS: Main: 175566848 11:31:26 INFO - PID 30282 | 11:31:28 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46780/tests/kraken/driver.html?testName=audio-dft) 11:31:29 INFO - PID 30282 | RSS: Main: 176181248 11:31:29 INFO - PID 30282 | 11:31:32 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46780/tests/kraken/driver.html?testName=audio-fft) 11:31:32 INFO - PID 30282 | RSS: Main: 171393024 11:31:32 INFO - PID 30282 | 11:31:35 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46780/tests/kraken/driver.html?testName=audio-oscillator) 11:31:35 INFO - PID 30282 | RSS: Main: 171876352 11:31:35 INFO - PID 30282 | 11:31:37 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:38 INFO - PID 30282 | RSS: Main: 172273664 11:31:38 INFO - PID 30282 | 11:31:41 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46780/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:42 INFO - PID 30282 | RSS: Main: 174608384 11:31:42 INFO - PID 30282 | 11:31:45 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46780/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:46 INFO - PID 30282 | RSS: Main: 174641152 11:31:46 INFO - PID 30282 | 11:31:49 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46780/tests/kraken/driver.html?testName=json-parse-financial) 11:31:50 INFO - PID 30282 | RSS: Main: 174415872 11:31:50 INFO - PID 30282 | 11:31:51 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:31:52 INFO - PID 30282 | RSS: Main: 174637056 11:31:52 INFO - PID 30282 | 11:31:54 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:31:54 INFO - PID 30282 | RSS: Main: 174743552 11:31:54 INFO - PID 30282 | 11:31:56 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:31:57 INFO - PID 30282 | RSS: Main: 171532288 11:31:57 INFO - PID 30282 | 11:32:00 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:00 INFO - PID 30282 | RSS: Main: 171921408 11:32:00 INFO - PID 30282 | 11:32:03 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:04 INFO - PID 30282 | RSS: Main: 172036096 11:32:04 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | Cycle 1(1): loaded http://localhost:46780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46780/tests/kraken/driver.html?testName=ai-astar) 11:32:06 INFO - PID 30282 | RSS: Main: 173694976 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | __start_tp_report 11:32:06 INFO - PID 30282 | _x_x_mozilla_page_load 11:32:06 INFO - PID 30282 | _x_x_mozilla_page_load_details 11:32:06 INFO - PID 30282 | |i|pagename|runs| 11:32:06 INFO - PID 30282 | |0;ai-astar;107;110;107;109;107;110;108;108;109;108 11:32:06 INFO - PID 30282 | |1;audio-beat-detection;119;115;121;118;119;120;145;121;117;116 11:32:06 INFO - PID 30282 | |2;audio-dft;166;166;166;167;166;168;173;175;166;166 11:32:06 INFO - PID 30282 | |3;audio-fft;75;75;75;74;75;76;75;73;74;74 11:32:06 INFO - PID 30282 | |4;audio-oscillator;81;79;80;79;82;80;79;78;78;78 11:32:06 INFO - PID 30282 | |5;imaging-gaussian-blur;110;123;114;116;113;113;113;111;114;111 11:32:06 INFO - PID 30282 | |6;imaging-darkroom;148;148;149;147;148;147;148;148;148;147 11:32:06 INFO - PID 30282 | |7;imaging-desaturate;98;94;94;94;94;94;95;96;98;94 11:32:06 INFO - PID 30282 | |8;json-parse-financial;53;53;53;51;51;51;52;53;54;63 11:32:06 INFO - PID 30282 | |9;json-stringify-tinderbox;39;38;38;37;37;39;39;39;38;39 11:32:06 INFO - PID 30282 | |10;stanford-crypto-aes;77;73;79;76;77;78;76;75;75;75 11:32:06 INFO - PID 30282 | |11;stanford-crypto-ccm;111;116;118;117;114;115;116;117;114;132 11:32:06 INFO - PID 30282 | |12;stanford-crypto-pbkdf2;190;169;172;170;177;171;171;172;170;175 11:32:06 INFO - PID 30282 | |13;stanford-crypto-sha256-iterative;67;69;80;66;66;65;68;64;69;66 11:32:06 INFO - PID 30282 | __end_tp_report 11:32:06 INFO - PID 30282 | __start_cc_report 11:32:06 INFO - PID 30282 | _x_x_mozilla_cycle_collect,952 11:32:06 INFO - PID 30282 | __end_cc_report 11:32:06 INFO - PID 30282 | __startTimestamp1505241126374__endTimestamp 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | ------- Summary: start ------- 11:32:06 INFO - PID 30282 | Number of tests: 14 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#0] ai-astar Cycles:10 Average:108.30 Median:108.50 stddev:1.16 (1.1%) stddev-sans-first:1.13 11:32:06 INFO - PID 30282 | Values: 107.0 110.0 107.0 109.0 107.0 110.0 108.0 108.0 109.0 108.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:119.50 stddev:8.63 (7.2%) stddev-sans-first:9.12 11:32:06 INFO - PID 30282 | Values: 119.0 115.0 121.0 118.0 119.0 120.0 145.0 121.0 117.0 116.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#2] audio-dft Cycles:10 Average:167.90 Median:166.50 stddev:3.31 (2.0%) stddev-sans-first:3.44 11:32:06 INFO - PID 30282 | Values: 166.0 166.0 166.0 167.0 166.0 168.0 173.0 175.0 166.0 166.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:0.84 (1.1%) stddev-sans-first:0.88 11:32:06 INFO - PID 30282 | Values: 75.0 75.0 75.0 74.0 75.0 76.0 75.0 73.0 74.0 74.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:1.35 (1.7%) stddev-sans-first:1.30 11:32:06 INFO - PID 30282 | Values: 81.0 79.0 80.0 79.0 82.0 80.0 79.0 78.0 78.0 78.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:113.50 stddev:3.68 (3.2%) stddev-sans-first:3.63 11:32:06 INFO - PID 30282 | Values: 110.0 123.0 114.0 116.0 113.0 113.0 113.0 111.0 114.0 111.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:32:06 INFO - PID 30282 | Values: 148.0 148.0 149.0 147.0 148.0 147.0 148.0 148.0 148.0 147.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.66 (1.8%) stddev-sans-first:1.39 11:32:06 INFO - PID 30282 | Values: 98.0 94.0 94.0 94.0 94.0 94.0 95.0 96.0 98.0 94.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:3.53 (6.7%) stddev-sans-first:3.75 11:32:06 INFO - PID 30282 | Values: 53.0 53.0 53.0 51.0 51.0 51.0 52.0 53.0 54.0 63.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:39.00 stddev:0.82 (2.1%) stddev-sans-first:0.83 11:32:06 INFO - PID 30282 | Values: 39.0 38.0 38.0 37.0 37.0 39.0 39.0 39.0 38.0 39.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.50 stddev:1.73 (2.3%) stddev-sans-first:1.80 11:32:06 INFO - PID 30282 | Values: 77.0 73.0 79.0 76.0 77.0 78.0 76.0 75.0 75.0 75.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:116.50 stddev:5.64 (4.8%) stddev-sans-first:5.55 11:32:06 INFO - PID 30282 | Values: 111.0 116.0 118.0 117.0 114.0 115.0 116.0 117.0 114.0 132.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:172.00 stddev:6.22 (3.6%) stddev-sans-first:2.57 11:32:06 INFO - PID 30282 | Values: 190.0 169.0 172.0 170.0 177.0 171.0 171.0 172.0 170.0 175.0 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:4.52 (6.7%) stddev-sans-first:4.78 11:32:06 INFO - PID 30282 | Values: 67.0 69.0 80.0 66.0 66.0 65.0 68.0 64.0 69.0 66.0 11:32:06 INFO - PID 30282 | -------- Summary: end -------- 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 11:32:06 INFO - PID 30282 | 11:32:06 INFO - PID 30282 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:32:07 INFO - TEST-INFO | 30282: exit 0 11:32:07 INFO - TEST-OK | kraken | took 61006ms 11:32:07 INFO - SUITE-END | took 1168s 11:32:07 INFO - Completed test suite (00:19:28) 11:32:07 INFO - javascript benchmark 11:32:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8510.734726179162, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.295458521833, 3152.763542734294, 3158.8578513966863, 3167.255694911695, 3178.1895616617758, 6040.577159598819, 6227.097070924713, 6241.282252540954, 6286.591371560851, 6364.14084098646, 6140.877182456359, 6176.75292988281, 6197.814065578029, 6201.317855035943, 6201.782937597185, 5716.114002329635, 5722.856928576798, 5813.534917206634, 5814.186013958049, 5820.767169313243, 5816.651000939957, 5856.297244330686, 5858.8242352729485, 5871.3541510433815, 5886.205362276102, 33.88843752579651, 5680.602357834932, 5683.090705487102, 5850.502707269887, 5881.558883083764, 5773.711314434261, 5786.392428795, 5852.092925596497, 5852.326982397036, 5857.707114644293, 5756.942430575683, 5775.509081728058, 5824.767009319622, 5838.2118414013985, 5847.502962248214, 6279.811605651837, 6294.7482100715915, 6299.716512756937, 6362.713677884506, 6383.106365108889, 6688.297728738461, 6726.865462690767, 6794.76218332356, 6805.523613347068, 6814.557053791487, 6578.572392794501, 6687.598744075371, 6697.464202863759, 6714.026466162379, 6782.593044417302, 6169.7532098716, 6207.596506227081, 6233.625982441068, 6314.684265786738, 6342.460890824285, 6899.551529150589, 6985.615791131435, 6987.196472405739, 6987.6855541500245, 6991.580505169706, 6586.473082153416, 6590.472762179014, 6610.0745895574655, 6681.899771503431, 6683.064370988066, 6544.247411547733, 6657.633830139292, 6661.766838160738, 6758.695858686371, 6784.151981002375, 6707.5304728668525, 6718.596884186964, 6725.495587830835, 6736.629485378351, 6763.864722705518, 6698.229703584053, 6732.798016059526, 6747.156605424322, 6822.624755638488, 6830.93169068303, 5074.162763144113, 5271.393789714155, 5314.92027619586, 5335.146376579729, 5340.759665815048, 4536.523665015192, 4578.793954272066, 4616.469106052847, 4654.045920586272, 4666.580007799314, 5800.274965629296, 5850.151727999501, 5870.44230798082, 5871.236739223874, 5876.559258055663, 6736.05695202672, 6772.288909664513, 6785.084013658192, 6848.760293389708, 6858.759943402057, 5708.1723150143, 5774.364819869811, 5793.2179155814265, 5797.710114494343, 5814.476697097197, 5777.768889244383, 5829.854253643693, 5846.590738648339, 5852.561057920588, 5861.794837180763, 6351.745930162834, 6416.518761092937, 6430.356964303533, 6548.541602087808, 6628.337166283333, 6581.670916454158, 6590.901136483052, 6594.241662208908, 6597.80206593803, 6598.94416893314, 6393.904091438539, 6413.454856337264, 6486.643234622141, 6575.835604109744, 6611.2727599963, 6566.146400967844, 6671.39957403836, 6696.196456425066, 6731.427828634621, 6760.053592496956, 6791.0, 6795.660216989032, 6847.383735463832, 6876.449884009167, 6878.140232470942, 6324.494040476843, 6447.161868957006, 6491.805245842632, 6564.5076619254705, 6568.80293591193, 6582.440492558187, 6610.867782644416, 6617.139771829631, 6618.404343609098, 6630.701618427086, 6448.065030570635, 6457.5479716419395, 6466.256380516301, 6544.705488253136, 6545.116409284686, 6555.80332590023, 6572.277049524644, 6612.50406219545, 6662.333766623299, 6668.499862510234, 6210.347913469021, 6253.812385628438, 6280.497560195265, 6328.367163283635, 6365.2361716594305], "value": 6088.796149086755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.1924552429667, 844.4089137603679, 855.5551113421021, 882.7131182365732, 888.3248730964465, 41622.16755664892, 41842.37236441456, 42067.57932420675, 42858.78570607147, 42865.78567107164, 42967.35548966768, 43274.350884736676, 43341.7832910835, 43375.78312108443, 43403.78298108505, 7645.923540764591, 7770.145284018753, 7776.0, 7777.766666999999, 7786.3381612563, 7638.809029774272, 7705.8844117338285, 7710.57591832449, 7720.034995625547, 7732.7680169595005, 7742.14836367999, 7779.377649788032, 7789.260020298063, 7791.883121753178, 7793.415493837956, 7737.187595302468, 7764.951731516229, 7768.57272849993, 7768.611569421506, 7768.650410731474, 7658.73194438192, 7728.343090837286, 7738.496997695188, 7757.4181936354435, 7760.223977602251, 38476.0, 38610.22779544422, 38741.22517549633, 38811.8059409704, 38886.41670374947, 3468.618451970281, 3514.7715398499017, 3516.753827232095, 3520.102373894666, 3528.964710352889, 32193.51709724356, 32256.35487290241, 32262.516062259085, 32269.193270168198, 32292.0, 4987.102321582114, 5120.820771273025, 5168.8449346519665, 5176.922346164811, 5184.326037615124, 187153.0, 187641.06179469152, 187784.0, 188085.0, 189018.0, 48081.0, 48245.75877120592, 48344.75827620839, 48363.51636483661, 48457.273140902915, 50251.497485025415, 50317.496825032016, 50357.49642503528, 50504.0, 50573.24140137901, 13734.381952812148, 13796.448142074205, 13963.441462341392, 13964.441422342992, 13965.092269002482, 11171.608993685344, 11206.551737930391, 11208.215424920178, 11218.439078046065, 11226.887731122748, 13051.694830517063, 13216.603501894959, 13238.602841914759, 13267.402966866513, 13387.933060334635, 5124.285657195314, 5130.30740849988, 5186.507281808223, 5211.1922651989, 5234.895302093937, 977.941323520591, 996.14829320931, 1002.5638847101388, 1021.5862575656871, 1026.7535791410007, 22052.11791528321, 22195.22316718907, 22294.55410891773, 22482.32553023412, 22513.099476020776, 1080.065743132185, 1089.9509522071526, 1097.1223021582862, 1101.2016288190998, 1104.9005589496824, 11918.523259069714, 11927.0, 11941.582044628396, 11972.64082077539, 12063.276203427822, 202723.0, 202912.0, 203660.0, 224993.0, 229304.0, 55637.721811390686, 55891.44108558862, 56037.439625604035, 56080.43919560752, 56196.0, 1401.5935378740255, 1404.8524904885044, 1407.134612213502, 1410.499272758197, 1429.428228708525, 26558.86720566385, 26647.0, 26871.696491911276, 27205.455890882466, 27247.45505089927, 37761.62238377581, 37853.053673657276, 37872.81063594665, 37887.62112378841, 37912.62087379091, 188458.0, 190038.0, 190171.0, 191093.04453477645, 191274.0, 33795.0, 33840.83079584586, 33905.83047084749, 33931.83034084814, 34005.65994340025, 41903.7904810474, 43359.566404336816, 43541.0, 43655.34516982184, 43861.342079869464, 31441.685583143877, 31539.211519711273, 31629.36741265208, 31634.841825790725, 32055.198620034687, 31290.530642039932, 31615.36769264648, 31876.5218521727, 31888.36223275475, 32131.19672008125, 34818.65181348154, 35751.82124089467, 35937.28125437529, 36031.0, 36194.819025904704, 31480.527792083594, 31508.0, 31741.365172695954, 31775.6822431782, 31811.840940795148, 22946.42633934165, 23088.53822923566, 23160.619948920714, 23381.76618233796, 23555.41111472227], "value": 16952.84064637363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8321122957494, 571.8370264474626, 572.3246569048522, 582.2983305117334, 584.1179818474104, 21874.562508749834, 22603.208887688954, 22649.433764155903, 22807.201747938827, 22819.77180228197, 23338.64992025121, 24433.144839930606, 24733.134340298093, 24783.132590359295, 24822.379440513996, 6436.742530298782, 6622.470202383822, 6627.701753421084, 6631.900521492182, 6634.104395906539, 6338.841528961767, 6496.317886621884, 6566.901496477557, 6592.604443733391, 6599.6370199639005, 6544.018397240405, 6545.9018114728315, 6546.574472659262, 6546.574472659286, 6554.8689026219445, 6524.0, 6524.706388212542, 6524.804255872307, 6526.54314198004, 6550.8034758957065, 6690.698918548628, 6993.580385176906, 6994.5803251805055, 6998.405135563483, 7002.0, 29644.70355296441, 30302.545461818092, 30308.8484557578, 30310.242243943856, 30317.393652127055, 2006.388051644248, 2033.2273735980382, 2037.0425899827057, 2037.4091513461078, 2037.9796202037937, 19788.604227915504, 20028.69956950647, 20369.5926081479, 20940.0, 21068.26261080855, 2497.4880149569294, 2504.8622325772258, 2559.6160575913577, 2580.7548282913094, 2586.521493523704, 117370.0, 123883.38058309742, 124157.0, 136031.31984340015, 142944.0, 19769.40691779249, 20746.0, 21154.365369038955, 21261.830599316876, 21390.358289251035, 41426.0, 41568.96077598084, 41594.58405415968, 41656.79171604183, 41697.37453938193, 9583.472908990072, 9725.854112188323, 9775.804483910282, 9854.852177217204, 9929.3545919515, 7814.296713295831, 7854.567998760009, 7872.772952264897, 7933.286004259644, 7946.125926148119, 10682.679519614425, 10923.672289831318, 11023.503942322615, 11244.0, 11269.887301126884, 3908.55051669056, 4056.716029877939, 4233.534311225762, 4314.805833737427, 4387.4954380246045, 928.122923836981, 954.5942974235921, 957.6696039866235, 971.1502435369052, 976.3897564022486, 18574.721379179322, 18707.71938420925, 18728.1907713844, 18774.436766897015, 18807.15367808452, 986.7779749556292, 1009.5255230041869, 1011.0698157694939, 1024.4314405505015, 1028.0695970147028, 10286.948565257275, 10353.0, 10401.27191096616, 10404.375737455777, 10719.517621707042, 432578.0, 446126.0, 446129.0, 450161.0, 456171.0, 109417.0, 110009.0, 112197.0, 112947.43526282316, 114044.0, 1018.8828284747201, 1068.71144790906, 1134.7163209197702, 1135.795556799784, 1177.8822117788152, 18789.248430062646, 19391.903040484707, 19505.0, 19529.0, 19730.112144953226, 56459.71770141123, 56599.71700141473, 56800.0, 57129.0, 57877.71061144667, 67314.66342668256, 70077.64961175162, 70257.64871175612, 70570.29429705637, 70663.64668176626, 19105.140268687665, 19167.712484313026, 19296.517587060436, 19403.8059619402, 19508.21967121356, 21962.0, 21986.780132199114, 22018.0, 22153.77846221517, 22338.66492002654, 17628.29486820513, 17742.29030838752, 17766.555836103682, 17829.0, 17963.101844907964, 15519.5344139676, 16133.112678802778, 16317.59206019859, 16326.428574999818, 16387.75418368749, 15683.1374274416, 17780.46658600244, 17914.193861276013, 18336.816631834045, 18559.25762969466, 18950.715739263647, 19067.0, 19095.14071866797, 19126.904365478083, 19456.805431946064, 17334.219960101575, 17426.390076347267, 17666.5583360417, 17758.37845675395, 17782.110894454967], "value": 12491.984763879615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.1318956945781, 1253.7805883970302, 1254.843144606924, 1261.2558590431643, 1264.772340978624, 14547.927260363696, 15195.772063419057, 15204.543863684094, 15217.16305603194, 15228.923855380708, 14858.925705371457, 14995.325210365532, 15006.099634021966, 15020.624484387896, 15020.924895375509, 2728.249731323882, 2731.8224315419484, 2785.679646840619, 2785.7214278572183, 2789.3584475570633, 2689.247010836959, 2728.01791355112, 2736.3979924416694, 2762.709915458878, 2765.5436852919242, 2655.5618322976684, 2706.120510833977, 2742.602322663213, 2746.7939904507143, 2757.076379412899, 2716.7962402819767, 2739.561670132769, 2783.6520434945633, 2784.3874347643587, 2786.1084452975056, 2615.3592369869502, 2743.684476285233, 2798.2864369585827, 2807.396409771909, 2809.12916995732, 14953.551393458105, 15020.248987550687, 15086.0, 15093.169875656835, 15100.924495377563, 7568.5458872467825, 7846.882296765553, 7896.170902055259, 7900.881486777703, 7910.248526389983, 5135.204043373283, 5159.819406320798, 5221.373435187764, 5271.604629652791, 5302.231176479428, 1937.9127939242767, 1942.2328180368675, 1957.5889063296725, 2000.249906285143, 2008.5681578460556, 25584.74415255842, 25714.48571028569, 26308.0, 26384.340391490365, 26927.730722692522, 7170.6056166910275, 7201.13586369639, 7281.308275713799, 7365.852682946311, 7416.7774966751085, 20012.099455524538, 20037.098330575158, 20048.198072076953, 20093.99060094008, 20127.194912203642, 7886.9211307887335, 7965.402594805413, 7980.680772769024, 7983.560904150211, 7997.200279971957, 7031.261717519689, 7114.217436082027, 7160.928390716131, 7173.246809085075, 7221.855562888818, 5593.0, 5705.71471426427, 5752.108423194411, 5753.223314852441, 5940.554458415636, 1633.3956436118474, 1664.142966372295, 1712.7859017622798, 1775.1213149491084, 1833.844123249512, 839.2740279658052, 854.1842540374053, 857.7855536115972, 862.6333808131519, 879.134052957836, 8204.441156180306, 8225.506469611842, 8385.916140838513, 8393.370497212734, 8445.704400345958, 888.8445519614908, 922.0, 950.4059962523423, 953.02315126994, 964.5273815830193, 5014.0, 5098.311727916758, 5133.563647089964, 5180.0, 5207.557357624644, 21031.57936841285, 22078.448038799157, 22161.0, 22180.778192218193, 22210.222642207445, 20572.691409628867, 21578.352649420227, 21601.567968640855, 21628.675569866464, 21779.564408711736, 10401.94799026, 10523.0, 10529.789404212026, 10624.787504250025, 10644.148468122532, 8128.87806682912, 8232.765085237263, 8266.380021498531, 8380.287675547646, 8422.873656895274, 18212.271509139486, 18552.072396380398, 18604.0, 18700.158492868126, 18960.810391895906, 18611.255549777856, 18822.6235475287, 18851.528711781768, 18867.716984244973, 18937.33719319817, 11734.823977640172, 11956.521739130685, 11965.222260553037, 12099.0, 12110.970567501861, 13526.0, 13579.728405432033, 13599.456021759019, 13672.726545469233, 13719.725605487634, 11143.442827858737, 11246.268992515461, 11246.83129753038, 11359.54561817518, 11561.537538498365, 10680.62617808373, 10816.837747433952, 10820.0, 10989.670309890716, 11066.39134847591, 9541.856872147062, 9736.41581505112, 9788.168005719308, 9816.361936474392, 9835.311528192959, 6851.246362899978, 6884.311568843075, 6958.826029349307, 6966.12923384577, 6992.965035174791, 6842.418394436529, 6918.204406493318, 6923.0, 7001.229864714979, 7044.15470143586], "value": 6696.493951494757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.59769398566516, 500.6682225280754, 520.398939225195, 526.108246522145, 529.3409704917378, 6187.4740647045, 6241.126242326078, 6246.500279977602, 6298.464630506407, 6322.450999505116, 6140.508759299257, 6212.471939885115, 6214.316425193237, 6228.22147231596, 6243.875122497559, 5177.767000484969, 5188.247704082905, 5194.63637545372, 5195.636305458619, 5227.0, 4777.426708794949, 5098.107831129556, 5100.260462232974, 5170.715610641413, 5181.585473162157, 4900.558949694527, 4920.950790492103, 4930.7534623268875, 4933.925991110136, 4950.504949505057, 4901.8774530636665, 4910.803567857281, 4924.138275801738, 4926.187179115442, 4945.35710357653, 4423.225935461282, 4423.270160423526, 4735.976320118378, 4783.808647654089, 4812.542808433193, 6064.484518815906, 6069.817905462844, 6074.48366888815, 6075.848103797396, 6084.878302433971, 5901.616394934315, 5933.762649494015, 5940.198073260098, 5949.970250148722, 5991.3109992351, 6510.772122975721, 6551.508636852255, 6565.785329714018, 6604.8348791280605, 6637.369449902251, 4954.504549545017, 5215.973920130413, 5261.0, 5271.499207575274, 5277.815276465305, 6712.731490740413, 6741.696623651947, 6798.966005169992, 6802.591844489347, 6832.385085342294, 5393.2179833923865, 5398.514133727984, 5398.568114550826, 5398.811041613603, 5434.91847622286, 5439.374471935699, 5482.095454250004, 5510.724463776795, 5520.227168196456, 5523.337199536081, 5922.674252916131, 5934.198883150806, 5967.5524335675, 5974.940250597525, 5977.760889564369, 6428.678566071678, 6481.740730370827, 6535.379138981789, 6618.238902526175, 6625.469962402996, 1871.7739880378374, 1880.3042874136656, 1883.3784850999136, 1885.2270569066616, 1910.3027395000724, 1362.209918247434, 1416.3060100550863, 1418.7517184492672, 1432.3268064009899, 1434.0678558936775, 5530.917036244459, 5531.861703457445, 5549.0, 5613.214150019001, 5644.57665675076, 6478.740850366027, 6593.142891424084, 6602.7028783704845, 6658.500612454085, 6703.195616526048, 5596.832095037155, 5622.32532096151, 5623.662580245198, 5701.800436984686, 5704.543636509069, 3420.1620602952435, 3477.14809871578, 3480.373532764076, 3531.2407832316176, 3558.1104723819044, 6419.935800642027, 6429.453496452854, 6477.611343319416, 6478.222613286436, 6493.155889734304, 6700.631465269359, 6751.628660423626, 6774.83062923421, 6779.2881747416795, 6875.5530890491955, 6335.049742538656, 6389.552731308764, 6404.398900274931, 6431.517636177306, 6456.9668852983295, 6579.243387010555, 6581.012848072636, 6591.143151390289, 6651.102101216274, 6683.8997415039785, 6548.672566371758, 6552.410283074546, 6576.408123268929, 6613.404793568602, 6634.601923884582, 6267.780627678009, 6336.619802811846, 6375.139356186855, 6409.551331406757, 6417.358264173546, 4832.903341933212, 4877.951220487892, 4899.877503062452, 4904.803807847647, 4922.92615610759, 6341.841453963688, 6466.579672321284, 6504.479641628753, 6631.602103873783, 6641.601503909781, 6251.78118765841, 6382.5532212744665, 6396.648184349905, 6402.167718196604, 6463.741450341934, 6232.345603711727, 6277.435030847063, 6382.648954307558, 6384.3934826191435, 6385.808425747235, 6039.396060393926, 6217.191765070512, 6223.408776166257, 6233.314335423009, 6347.841303967438, 6311.684415779101, 6471.191101112361, 6487.021458455028, 6513.706883190173, 6574.638394888327, 6244.625322480666, 6293.465055470337, 6311.779087731908, 6324.1146239527425, 6346.6037471756135], "value": 5092.469044073632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.7948932000975, 898.4923518212214, 900.1223806788381, 902.7878448564586, 915.5330781301536, 18872.433826985194, 19750.70373944392, 19851.801481985174, 19868.006599670032, 19940.900295498537, 16987.83012169878, 17104.0, 17180.484585462455, 17246.31014759411, 17511.562210944732, 943.5423819447562, 944.584382871536, 945.9479728614923, 949.2311227905384, 951.1344676344528, 944.2210176604294, 944.4522177137278, 946.2288235088415, 950.6720181537393, 967.2552134856156, 1021.9284650074461, 1032.1587905856702, 1032.4682788363998, 1032.9225308101884, 1033.0392734756674, 1022.0, 1022.0290723812408, 1022.5551884930042, 1023.0281232828843, 1024.0732137415614, 716.3481232078783, 734.9154847192588, 740.28932225064, 740.6000759589815, 742.2985278911431, 19953.800461995485, 20139.6979045313, 20212.595748084957, 20231.190752369886, 20259.696104558443, 20920.37238882836, 20937.26719564823, 21490.78509214919, 21604.0, 21621.67567486489, 15981.760273595906, 16245.268962896698, 16301.51095467138, 16355.182240887909, 16446.75329870053, 3758.4550240215017, 3784.924301513982, 3792.886213413602, 3794.677452416548, 3803.6386543278345, 130866.0, 136665.0, 138479.0, 138819.30590347084, 141070.2946485261, 16711.0, 16803.579910502336, 16985.660286794442, 17029.57426064358, 17055.317787288368, 29603.851980739957, 29664.851675741484, 29787.85106074499, 29801.0, 29802.10593682193, 8438.789030274169, 8500.787480313042, 8501.574921253912, 8502.829943401097, 8533.74398768038, 3850.845966161322, 3869.1487872667967, 3889.4749208857006, 3892.9805350973065, 3895.6104389561383, 4717.127331443694, 5069.087564238399, 5085.059264036166, 5096.159133742965, 5126.7180305083575, 968.5689868008668, 968.9273304502191, 990.2028866762325, 994.0506815990711, 994.4530508220449, 662.4336192555392, 684.5687217053224, 692.1693967239333, 697.9651017449208, 703.0930100170825, 11302.886971130349, 11385.203035787416, 11835.822462663067, 11956.282623042645, 12192.512299508098, 604.8125081224835, 608.7564974010431, 608.9269287685506, 614.241411856357, 635.1489004733679, 5629.0, 5650.463205995424, 5705.800296989585, 5723.998300297431, 5728.684922329228, 124037.0, 125274.98900043896, 126384.2248340932, 128598.35700821436, 129424.352878235, 107309.0, 107518.46240768746, 107815.46092269488, 109548.4522577398, 114604.42697786458, 94110.52944735232, 95635.0, 96101.51949240209, 97317.0, 97600.51199743956, 9985.950070249894, 10128.531362952182, 10443.216758742972, 10459.790804183722, 10461.372317660966, 42521.36217956795, 43532.0, 44038.0, 44048.339274910264, 44127.33808992804, 56953.71523142358, 57659.4234057654, 58020.0, 58882.41117588769, 59076.0, 14251.144931304156, 14323.928380358031, 14334.856651433352, 14498.927505362406, 14498.927505362406, 16214.027158370536, 16338.836611634208, 16428.42500512476, 16530.421435249707, 16566.088865112535, 15456.304466298818, 15514.9224253878, 15593.610159746097, 15723.842761572238, 15742.449014284444, 12233.143679942319, 12323.198992065487, 12345.753084938071, 12375.0, 12375.443105060474, 13467.932660336635, 13589.932050339685, 13596.456141754219, 13684.0, 13752.243626600233, 11863.288202707865, 12007.339596321937, 12008.39958002114, 12046.0, 12049.518019279481, 11090.16823738239, 11228.10175185967, 11282.702489213845, 11305.604303849326, 11516.078713703051], "value": 8641.619975702324, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 107.0, 109.0, 107.0, 110.0, 108.0, 108.0, 109.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 121.0, 118.0, 119.0, 120.0, 145.0, 121.0, 117.0, 116.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 167.0, 166.0, 168.0, 173.0, 175.0, 166.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 75.0, 76.0, 75.0, 73.0, 74.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 79.0, 82.0, 80.0, 79.0, 78.0, 78.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 123.0, 114.0, 116.0, 113.0, 113.0, 113.0, 111.0, 114.0, 111.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 96.0, 98.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 51.0, 51.0, 51.0, 52.0, 53.0, 54.0, 63.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 37.0, 37.0, 39.0, 39.0, 39.0, 38.0, 39.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 79.0, 76.0, 77.0, 78.0, 76.0, 75.0, 75.0, 75.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 118.0, 117.0, 114.0, 115.0, 116.0, 117.0, 114.0, 132.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 169.0, 172.0, 170.0, 177.0, 171.0, 171.0, 172.0, 170.0, 175.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 80.0, 66.0, 66.0, 65.0, 68.0, 64.0, 69.0, 66.0], "value": 68.0, "unit": "score"}]}]} 11:32:07 INFO - Return code: 0 11:32:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:32:07 INFO - # TBPL SUCCESS # 11:32:07 INFO - Running post-action listener: _package_coverage_data 11:32:07 INFO - Running post-action listener: _resource_record_post_action 11:32:07 INFO - [mozharness: 2017-09-12 18:32:07.647137Z] Finished run-tests step (success) 11:32:07 INFO - Running post-run listener: _resource_record_post_run 11:32:07 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 301588480; Read time: 180; Write time: 273700 11:32:07 INFO - TinderboxPrint: CPU usage
13.1% 11:32:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 11:32:07 INFO - TinderboxPrint: I/O write bytes / time
301,588,480 / 273,700 11:32:07 INFO - TinderboxPrint: CPU idle
8,214.3 (86.9%) 11:32:07 INFO - TinderboxPrint: CPU user
1,190.4 (12.6%) 11:32:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:32:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 19566592; Read time: 0; Write time: 3480 11:32:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:32:07 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282021888; Read time: 168; Write time: 270220 11:32:08 INFO - Running post-run listener: _upload_blobber_files 11:32:08 INFO - Blob upload gear active. 11:32:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:32:08 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 11:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:32:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:10 INFO - (blobuploader) - INFO - Done attempting. 11:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:11 INFO - (blobuploader) - INFO - Done attempting. 11:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:32:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:18 INFO - (blobuploader) - INFO - Done attempting. 11:32:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:32:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:32:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:32:19 INFO - (blobuploader) - INFO - Done attempting. 11:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:32:19 INFO - Return code: 0 11:32:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:32:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:32:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef1683035d177332ba79adb6929e2c4cf93a6d6d6e62612b97a3af3f0ee5c50a68b88e63e1e870e0d87b9ea53f891be2865b25e3ce38d615f2651f0ba19eed7e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/583abf2ec71c1c91a48d055f2863f24400f4b1d3281e0809b3701398cb27083199bd74d9c7d7572a7d9b8d7e24c3e3a40468c3bde17d755726420f524e0cc99f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dacc5fd1f07a5dff0b43e930fb5812f6adc2e2e13c664ac3123638d95cdd6f0a13ad38482ac34ea2be399ac1b7d61cc479b9503ddd4a42f286058a2825d4d409", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b3bae1646cf06bd0fcd8cb6f0535572d19803dfb56f04c782b7c68cd11c774172743b18cda0851482dde941816c8061642de2bddc7aff8e9d14e0beef5ee42a"} 11:32:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:32:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:32:19 INFO - Contents: 11:32:19 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef1683035d177332ba79adb6929e2c4cf93a6d6d6e62612b97a3af3f0ee5c50a68b88e63e1e870e0d87b9ea53f891be2865b25e3ce38d615f2651f0ba19eed7e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/583abf2ec71c1c91a48d055f2863f24400f4b1d3281e0809b3701398cb27083199bd74d9c7d7572a7d9b8d7e24c3e3a40468c3bde17d755726420f524e0cc99f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dacc5fd1f07a5dff0b43e930fb5812f6adc2e2e13c664ac3123638d95cdd6f0a13ad38482ac34ea2be399ac1b7d61cc479b9503ddd4a42f286058a2825d4d409", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b3bae1646cf06bd0fcd8cb6f0535572d19803dfb56f04c782b7c68cd11c774172743b18cda0851482dde941816c8061642de2bddc7aff8e9d14e0beef5ee42a"} 11:32:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:32:19 INFO - Copying logs to upload dir... 11:32:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:32:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.452216 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-09-12 11:32:19.807388) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 11:32:19.810557) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef1683035d177332ba79adb6929e2c4cf93a6d6d6e62612b97a3af3f0ee5c50a68b88e63e1e870e0d87b9ea53f891be2865b25e3ce38d615f2651f0ba19eed7e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/583abf2ec71c1c91a48d055f2863f24400f4b1d3281e0809b3701398cb27083199bd74d9c7d7572a7d9b8d7e24c3e3a40468c3bde17d755726420f524e0cc99f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dacc5fd1f07a5dff0b43e930fb5812f6adc2e2e13c664ac3123638d95cdd6f0a13ad38482ac34ea2be399ac1b7d61cc479b9503ddd4a42f286058a2825d4d409", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b3bae1646cf06bd0fcd8cb6f0535572d19803dfb56f04c782b7c68cd11c774172743b18cda0851482dde941816c8061642de2bddc7aff8e9d14e0beef5ee42a"} build_url:https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011835 build_url: 'https://queue.taskcluster.net/v1/task/FQjg94SATyS0BGw0f0JD1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef1683035d177332ba79adb6929e2c4cf93a6d6d6e62612b97a3af3f0ee5c50a68b88e63e1e870e0d87b9ea53f891be2865b25e3ce38d615f2651f0ba19eed7e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/583abf2ec71c1c91a48d055f2863f24400f4b1d3281e0809b3701398cb27083199bd74d9c7d7572a7d9b8d7e24c3e3a40468c3bde17d755726420f524e0cc99f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dacc5fd1f07a5dff0b43e930fb5812f6adc2e2e13c664ac3123638d95cdd6f0a13ad38482ac34ea2be399ac1b7d61cc479b9503ddd4a42f286058a2825d4d409", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b3bae1646cf06bd0fcd8cb6f0535572d19803dfb56f04c782b7c68cd11c774172743b18cda0851482dde941816c8061642de2bddc7aff8e9d14e0beef5ee42a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 11:32:19.839265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:32:19.839589) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505232102.61685-1148445458 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:32:19.925421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 11:32:19.925749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 11:32:19.926074) ========= ========= Total master_lag: 0.22 =========