builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1505211923.2 results: success (0) revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.201447) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.202450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.202789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.262114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.262491) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 03:25: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.0M=0.001s 2017-09-12 03:25:23 (23.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268539 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.549067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.549466) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018241 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.599524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:23.599875) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 175f1366daee80cde53386a4627402ed3af4c038 --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 175f1366daee80cde53386a4627402ed3af4c038 --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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 03:25:23,659 truncating revision to first 12 chars 2017-09-12 03:25:23,660 Setting DEBUG logging. 2017-09-12 03:25:23,660 attempt 1/10 2017-09-12 03:25:23,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/175f1366daee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 03:25:24,276 unpacking tar archive at: mozilla-central-175f1366daee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.551728) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.552088) ========= script_repo_revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.552553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.552881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.568765) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-12 03:25:24.569181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:24 INFO - MultiFileLogger online at 20170912 03:25:24 in /builds/slave/test 03:25:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-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 03:25:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:24 INFO - {'append_to_log': False, 03:25:24 INFO - 'base_work_dir': '/builds/slave/test', 03:25:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:25:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:24 INFO - 'branch': 'Firefox-Non-PGO', 03:25:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:24 INFO - 'code_coverage': False, 03:25:24 INFO - 'config_files': ('talos/linux_config.py',), 03:25:24 INFO - 'default_actions': ('clobber', 03:25:24 INFO - 'read-buildbot-config', 03:25:24 INFO - 'download-and-extract', 03:25:24 INFO - 'populate-webroot', 03:25:24 INFO - 'create-virtualenv', 03:25:24 INFO - 'install', 03:25:24 INFO - 'setup-mitmproxy', 03:25:24 INFO - 'run-tests'), 03:25:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:24 INFO - 'disable_ccov_upload': False, 03:25:24 INFO - 'disable_stylo': False, 03:25:24 INFO - 'download_minidump_stackwalk': True, 03:25:24 INFO - 'download_symbols': 'ondemand', 03:25:24 INFO - 'enable_stylo': False, 03:25:24 INFO - 'enable_webrender': False, 03:25:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:25:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:24 INFO - 'gecko_profile': False, 03:25:24 INFO - 'gecko_profile_interval': 0, 03:25:24 INFO - 'installer_path': 'installer.exe', 03:25:24 INFO - 'log_level': 'info', 03:25:24 INFO - 'log_name': 'talos', 03:25:24 INFO - 'log_to_console': True, 03:25:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:24 INFO - 'opt_config_files': (), 03:25:24 INFO - 'pip_index': False, 03:25:24 INFO - 'suite': 'dromaeojs-e10s', 03:25:24 INFO - 'system_bits': '32', 03:25:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:24 INFO - 'title': 'talos-linux64-ix-046', 03:25:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:24 INFO - 'use_talos_json': True, 03:25:24 INFO - 'verify': 'False', 03:25:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:24 INFO - 'work_dir': 'build'} 03:25:24 INFO - [mozharness: 2017-09-12 10:25:24.769209Z] Running clobber step. 03:25:24 INFO - Running pre-action listener: _resource_record_pre_action 03:25:24 INFO - Running main action method: clobber 03:25:24 INFO - rmtree: /builds/slave/test/build 03:25:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:25 INFO - Running post-action listener: _resource_record_post_action 03:25:25 INFO - [mozharness: 2017-09-12 10:25:25.793886Z] Finished clobber step (success) 03:25:25 INFO - [mozharness: 2017-09-12 10:25:25.793983Z] Running read-buildbot-config step. 03:25:25 INFO - Running pre-action listener: _resource_record_pre_action 03:25:25 INFO - Running main action method: read_buildbot_config 03:25:25 INFO - Using buildbot properties: 03:25:25 INFO - { 03:25:25 INFO - "project": "", 03:25:25 INFO - "product": "firefox", 03:25:25 INFO - "who": "archaeopteryx@coole-files.de", 03:25:25 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:25:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:25:25 INFO - "stage_platform": "linux64", 03:25:25 INFO - "basedir": "/builds/slave/test", 03:25:25 INFO - "buildnumber": 1141, 03:25:25 INFO - "platform": "ubuntu64_hw", 03:25:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:25:25 INFO - "slavebuilddir": "test", 03:25:25 INFO - "taskId": "BznYP5zeSbCIgXJfs71waA", 03:25:25 INFO - "branch": "mozilla-central", 03:25:25 INFO - "script_repo_revision": "production", 03:25:25 INFO - "revision": "175f1366daee80cde53386a4627402ed3af4c038", 03:25:25 INFO - "slavename": "talos-linux64-ix-046", 03:25:25 INFO - "repo_path": "mozilla-central" 03:25:25 INFO - } 03:25:25 INFO - Finding installer, test and symbols from parent task. 03:25:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BznYP5zeSbCIgXJfs71waA'}, attempt #1 03:25:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BznYP5zeSbCIgXJfs71waA'}, attempt #1 03:25:26 INFO - Task dependencies: c8J8p6RuRZ-xxUSm_NtOkg 03:25:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg'}, attempt #1 03:25:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip 03:25:27 INFO - Running post-action listener: _resource_record_post_action 03:25:27 INFO - [mozharness: 2017-09-12 10:25:27.130794Z] Finished read-buildbot-config step (success) 03:25:27 INFO - [mozharness: 2017-09-12 10:25:27.131010Z] Running download-and-extract step. 03:25:27 INFO - Running pre-action listener: _resource_record_pre_action 03:25:27 INFO - Running main action method: download_and_extract 03:25:27 INFO - mkdir: /builds/slave/test/build/tests 03:25: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')]} 03:25:27 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:27 INFO - Downloading https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:25:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:25:27 INFO - Downloaded 989 bytes. 03:25:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:27 INFO - Using the following test package requirements: 03:25:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:27 INFO - u'common': [u'target.common.tests.zip'], 03:25:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:27 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:27 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:27 INFO - u'target.web-platform.tests.tar.gz'], 03:25:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:25:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip 03:25:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:27 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip into memory 03:25:28 INFO - Content-Length response header: 55043807 03:25:28 INFO - Bytes received: 55043807 03:25:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip 03:25:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:25:39 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip into memory 03:25:40 INFO - Content-Length response header: 14499231 03:25:40 INFO - Bytes received: 14499231 03:25:40 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')]} 03:25:40 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:40 INFO - Downloading https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:25:43 INFO - Downloaded 63128717 bytes. 03:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:44 INFO - mkdir: /builds/slave/test/properties 03:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:44 INFO - Contents: 03:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:44 INFO - Running post-action listener: _resource_record_post_action 03:25:44 INFO - Running post-action listener: find_tests_for_verification 03:25:44 INFO - Running post-action listener: set_extra_try_arguments 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.019711Z] Finished download-and-extract step (success) 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.019942Z] Running populate-webroot step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: populate_webroot 03:25:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tresize', 03:25:44 INFO - 'tcanvasmark']}, 03:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['dromaeo_css', 03:25:44 INFO - 'kraken']}, 03:25:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['damp', 'tps']}, 03:25:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['damp', 'tps']}, 03:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['dromaeo_dom']}, 03:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['basic_compositor_video', 03:25:44 INFO - 'glvideo']}, 03:25:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['ts_paint_webext', 03:25:44 INFO - 'tp5o_webext']}, 03:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:44 INFO - 'ts_paint', 03:25:44 INFO - 'tpaint', 03:25:44 INFO - 'sessionrestore', 03:25:44 INFO - 'sessionrestore_many_windows', 03:25:44 INFO - 'sessionrestore_no_auto_restore', 03:25:44 INFO - 'tabpaint']}, 03:25:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['a11yr', 03:25:44 INFO - 'ts_paint', 03:25:44 INFO - 'tpaint', 03:25:44 INFO - 'sessionrestore', 03:25:44 INFO - 'sessionrestore_many_windows', 03:25:44 INFO - 'sessionrestore_no_auto_restore', 03:25:44 INFO - 'tabpaint']}, 03:25:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['bloom_basic']}, 03:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:44 INFO - 'tsvgr_opacity', 03:25:44 INFO - 'tart', 03:25:44 INFO - 'tscrollx', 03:25:44 INFO - 'tsvg_static']}, 03:25:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tsvgx', 03:25:44 INFO - 'tsvgr_opacity', 03:25:44 INFO - 'tart', 03:25:44 INFO - 'tscrollx', 03:25:44 INFO - 'tsvg_static']}, 03:25:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tp5o']}, 03:25:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo', 03:25:44 INFO - '--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--stylo-threads=1', 03:25:44 INFO - '--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--xperf_path', 03:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:44 INFO - 'tests': ['tp5n']}, 03:25:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo', 03:25:44 INFO - '--xperf_path', 03:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:44 INFO - 'tests': ['tp5n']}}} 03:25:44 INFO - Running post-action listener: _resource_record_post_action 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.147201Z] Finished populate-webroot step (success) 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.147295Z] Running create-virtualenv step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: create_virtualenv 03:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:25:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:45 INFO - Installing pip...............done. 03:25:45 INFO - Return code: 0 03:25:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:45 INFO - Reading from file tmpfile_stdout 03:25:45 INFO - Output received: 03:25:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:45 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')]} 03:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:45 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')]} 03:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:45 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:45 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 03:25:45 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 03:25:45 INFO - Using env: {'DISPLAY': ':0', 03:25:45 INFO - 'HOME': '/home/cltbld', 03:25:45 INFO - 'LANG': 'en_US.UTF-8', 03:25:45 INFO - 'LANGUAGE': 'en_US:en', 03:25:45 INFO - 'LOGNAME': 'cltbld', 03:25:45 INFO - 'MAIL': '/var/mail/cltbld', 03:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:45 INFO - 'MOZ_NO_REMOTE': '1', 03:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:45 INFO - 'NO_EM_RESTART': '1', 03:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:45 INFO - 'PWD': '/builds/slave/test', 03:25:45 INFO - 'SHELL': '/bin/bash', 03:25:45 INFO - 'SHLVL': '1', 03:25:45 INFO - 'TERM': 'linux', 03:25:45 INFO - 'TMOUT': '86400', 03:25:45 INFO - 'USER': 'cltbld', 03:25:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:45 INFO - '_': '/tools/buildbot/bin/python'} 03:25:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:25:47 INFO - Downloading/unpacking pip>=1.5 03:25:47 INFO - Running setup.py egg_info for package pip 03:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:47 INFO - Installing collected packages: pip 03:25:47 INFO - Found existing installation: pip 1.1 03:25:47 INFO - Uninstalling pip: 03:25:47 INFO - Successfully uninstalled pip 03:25:47 INFO - Running setup.py install for pip 03:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:25:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:25:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:25:47 INFO - Successfully installed pip 03:25:47 INFO - Cleaning up... 03:25:47 INFO - Return code: 0 03:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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')]} 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25: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', '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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:25: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 psutil>=3.1.1 03:25:47 INFO - Using env: {'DISPLAY': ':0', 03:25:47 INFO - 'HOME': '/home/cltbld', 03:25:47 INFO - 'LANG': 'en_US.UTF-8', 03:25:47 INFO - 'LANGUAGE': 'en_US:en', 03:25:47 INFO - 'LOGNAME': 'cltbld', 03:25:47 INFO - 'MAIL': '/var/mail/cltbld', 03:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:47 INFO - 'MOZ_NO_REMOTE': '1', 03:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:47 INFO - 'NO_EM_RESTART': '1', 03:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:47 INFO - 'PWD': '/builds/slave/test', 03:25:47 INFO - 'SHELL': '/bin/bash', 03:25:47 INFO - 'SHLVL': '1', 03:25:47 INFO - 'TERM': 'linux', 03:25:47 INFO - 'TMOUT': '86400', 03:25:47 INFO - 'USER': 'cltbld', 03:25:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:47 INFO - '_': '/tools/buildbot/bin/python'} 03:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:47 INFO - Downloading/unpacking psutil>=3.1.1 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:48 INFO - Installing collected packages: psutil 03:25:48 INFO - Running setup.py install for psutil 03:25:48 INFO - building 'psutil._psutil_linux' extension 03:25:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:49 INFO - building 'psutil._psutil_posix' extension 03:25:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Successfully installed psutil 03:25:50 INFO - Cleaning up... 03:25:51 INFO - Return code: 0 03:25:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:51 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')]} 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:51 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')]} 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:51 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 03:25:51 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 03:25:51 INFO - Using env: {'DISPLAY': ':0', 03:25:51 INFO - 'HOME': '/home/cltbld', 03:25:51 INFO - 'LANG': 'en_US.UTF-8', 03:25:51 INFO - 'LANGUAGE': 'en_US:en', 03:25:51 INFO - 'LOGNAME': 'cltbld', 03:25:51 INFO - 'MAIL': '/var/mail/cltbld', 03:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:51 INFO - 'MOZ_NO_REMOTE': '1', 03:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:51 INFO - 'NO_EM_RESTART': '1', 03:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:51 INFO - 'PWD': '/builds/slave/test', 03:25:51 INFO - 'SHELL': '/bin/bash', 03:25:51 INFO - 'SHLVL': '1', 03:25:51 INFO - 'TERM': 'linux', 03:25:51 INFO - 'TMOUT': '86400', 03:25:51 INFO - 'USER': 'cltbld', 03:25:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:51 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:52 INFO - Installing collected packages: mozsystemmonitor 03:25:52 INFO - Running setup.py install for mozsystemmonitor 03:25:52 INFO - Successfully installed mozsystemmonitor 03:25:52 INFO - Cleaning up... 03:25:52 INFO - Return code: 0 03:25:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:52 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')]} 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:52 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')]} 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:52 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:52 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 03:25:52 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 03:25:52 INFO - Using env: {'DISPLAY': ':0', 03:25:52 INFO - 'HOME': '/home/cltbld', 03:25:52 INFO - 'LANG': 'en_US.UTF-8', 03:25:52 INFO - 'LANGUAGE': 'en_US:en', 03:25:52 INFO - 'LOGNAME': 'cltbld', 03:25:52 INFO - 'MAIL': '/var/mail/cltbld', 03:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:52 INFO - 'MOZ_NO_REMOTE': '1', 03:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:52 INFO - 'NO_EM_RESTART': '1', 03:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:52 INFO - 'PWD': '/builds/slave/test', 03:25:52 INFO - 'SHELL': '/bin/bash', 03:25:52 INFO - 'SHLVL': '1', 03:25:52 INFO - 'TERM': 'linux', 03:25:52 INFO - 'TMOUT': '86400', 03:25:52 INFO - 'USER': 'cltbld', 03:25:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:52 INFO - '_': '/tools/buildbot/bin/python'} 03:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:54 INFO - warning: no files found matching '*.txt' 03:25:54 INFO - no previously-included directories found matching 'build' 03:25:54 INFO - no previously-included directories found matching 'dist' 03:25:54 INFO - no previously-included directories found matching '.git*' 03:25:54 INFO - Installing collected packages: jsonschema, functools32 03:25:54 INFO - Running setup.py install for functools32 03:25:54 INFO - warning: no files found matching '*.txt' 03:25:54 INFO - no previously-included directories found matching 'build' 03:25:54 INFO - no previously-included directories found matching 'dist' 03:25:54 INFO - no previously-included directories found matching '.git*' 03:25:54 INFO - Successfully installed jsonschema functools32 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:54 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')]} 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:54 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')]} 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:54 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:54 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 03:25:54 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 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:54 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')]} 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:54 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')]} 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:54 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:54 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 03:25:54 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 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - Downloading docopt-0.6.1.tar.gz 03:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:56 INFO - Running setup.py install for blobuploader 03:25:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:56 INFO - Running setup.py install for requests 03:25:56 INFO - Running setup.py install for docopt 03:25:57 INFO - Successfully installed blobuploader requests docopt 03:25:57 INFO - Cleaning up... 03:25:57 INFO - Return code: 0 03:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:57 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')]} 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:57 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')]} 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:57 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:25:57 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 03:25:57 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 03:25:57 INFO - Using env: {'DISPLAY': ':0', 03:25:57 INFO - 'HOME': '/home/cltbld', 03:25:57 INFO - 'LANG': 'en_US.UTF-8', 03:25:57 INFO - 'LANGUAGE': 'en_US:en', 03:25:57 INFO - 'LOGNAME': 'cltbld', 03:25:57 INFO - 'MAIL': '/var/mail/cltbld', 03:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:57 INFO - 'MOZ_NO_REMOTE': '1', 03:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:57 INFO - 'NO_EM_RESTART': '1', 03:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:57 INFO - 'PWD': '/builds/slave/test', 03:25:57 INFO - 'SHELL': '/bin/bash', 03:25:57 INFO - 'SHLVL': '1', 03:25:57 INFO - 'TERM': 'linux', 03:25:57 INFO - 'TMOUT': '86400', 03:25:57 INFO - 'USER': 'cltbld', 03:25:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:57 INFO - '_': '/tools/buildbot/bin/python'} 03:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:57 INFO - Running setup.py (path:/tmp/pip-i6xcAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:57 INFO - Running setup.py (path:/tmp/pip-nU0wj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:57 INFO - Running setup.py (path:/tmp/pip-dIj4E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:57 INFO - Running setup.py (path:/tmp/pip-H1hL3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:57 INFO - Running setup.py (path:/tmp/pip-UJ8XVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:57 INFO - Running setup.py (path:/tmp/pip-4snO8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:57 INFO - Running setup.py (path:/tmp/pip-eaJRu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:57 INFO - Running setup.py (path:/tmp/pip-KPhFcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:57 INFO - Running setup.py (path:/tmp/pip-SOQj7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:57 INFO - Running setup.py (path:/tmp/pip-2nRtoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:57 INFO - Running setup.py (path:/tmp/pip-JuXWT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:58 INFO - Running setup.py (path:/tmp/pip-M9nV9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:58 INFO - Running setup.py (path:/tmp/pip-soNxfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:58 INFO - Running setup.py (path:/tmp/pip-BzUhGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:58 INFO - Running setup.py (path:/tmp/pip-83U_3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:58 INFO - Running setup.py (path:/tmp/pip-6WkjOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:58 INFO - Running setup.py (path:/tmp/pip-c8ppMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:58 INFO - Running setup.py install for manifestparser 03:25:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozcrash 03:25:58 INFO - Running setup.py install for mozdebug 03:25:58 INFO - Running setup.py install for mozdevice 03:25:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozfile 03:25:58 INFO - Running setup.py install for mozhttpd 03:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozinfo 03:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozInstall 03:25:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozleak 03:25:59 INFO - Running setup.py install for mozlog 03:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for moznetwork 03:25:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozprocess 03:25:59 INFO - Running setup.py install for mozprofile 03:25:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozrunner 03:25:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozscreenshot 03:26:00 INFO - Running setup.py install for moztest 03:26:00 INFO - Running setup.py install for mozversion 03:26:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:00 INFO - Cleaning up... 03:26:00 INFO - Return code: 0 03:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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')]} 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:00 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:26:00 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 03:26:00 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 03:26:00 INFO - Using env: {'DISPLAY': ':0', 03:26:00 INFO - 'HOME': '/home/cltbld', 03:26:00 INFO - 'LANG': 'en_US.UTF-8', 03:26:00 INFO - 'LANGUAGE': 'en_US:en', 03:26:00 INFO - 'LOGNAME': 'cltbld', 03:26:00 INFO - 'MAIL': '/var/mail/cltbld', 03:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:00 INFO - 'MOZ_NO_REMOTE': '1', 03:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:00 INFO - 'NO_EM_RESTART': '1', 03:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:00 INFO - 'PWD': '/builds/slave/test', 03:26:00 INFO - 'SHELL': '/bin/bash', 03:26:00 INFO - 'SHLVL': '1', 03:26:00 INFO - 'TERM': 'linux', 03:26:00 INFO - 'TMOUT': '86400', 03:26:00 INFO - 'USER': 'cltbld', 03:26:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:00 INFO - '_': '/tools/buildbot/bin/python'} 03:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:00 INFO - Running setup.py (path:/tmp/pip-mLxS8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:00 INFO - Running setup.py (path:/tmp/pip-aJxQ_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:00 INFO - Running setup.py (path:/tmp/pip-RzG9fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:00 INFO - Running setup.py (path:/tmp/pip-Z7dBra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:00 INFO - Running setup.py (path:/tmp/pip-2dyh9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:00 INFO - Running setup.py (path:/tmp/pip-X5c4Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:00 INFO - Running setup.py (path:/tmp/pip-rFK4T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:00 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)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:00 INFO - Running setup.py (path:/tmp/pip-2mQon8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:01 INFO - Running setup.py (path:/tmp/pip-Jn8P3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:01 INFO - Running setup.py (path:/tmp/pip-IgN_ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:01 INFO - Running setup.py (path:/tmp/pip-m4XXUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:01 INFO - Running setup.py (path:/tmp/pip-cyJtHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:01 INFO - Running setup.py (path:/tmp/pip-vx71v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:01 INFO - Running setup.py (path:/tmp/pip-sOJEMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:01 INFO - Running setup.py (path:/tmp/pip-xCIuzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:01 INFO - Running setup.py (path:/tmp/pip-U3LUol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:01 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)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:01 INFO - Running setup.py (path:/tmp/pip-MjtcNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:01 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)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): 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)) 03:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:02 INFO - Downloading blessings-1.6.tar.gz 03:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:02 INFO - Installing collected packages: blessings 03:26:02 INFO - Running setup.py install for blessings 03:26:02 INFO - Successfully installed blessings 03:26:02 INFO - Cleaning up... 03:26:03 INFO - Return code: 0 03:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:03 INFO - Reading from file tmpfile_stdout 03:26:03 INFO - Current package versions: 03:26:03 INFO - argparse == 1.2.1 03:26:03 INFO - blessings == 1.6 03:26:03 INFO - blobuploader == 1.2.4 03:26:03 INFO - docopt == 0.6.1 03:26:03 INFO - functools32 == 3.2.3-2 03:26:03 INFO - jsonschema == 2.5.1 03:26:03 INFO - manifestparser == 1.1 03:26:03 INFO - mozInstall == 1.13 03:26:03 INFO - mozcrash == 1.0 03:26:03 INFO - mozdebug == 0.1 03:26:03 INFO - mozdevice == 0.51 03:26:03 INFO - mozfile == 1.2 03:26:03 INFO - mozhttpd == 0.7 03:26:03 INFO - mozinfo == 0.10 03:26:03 INFO - mozleak == 0.1 03:26:03 INFO - mozlog == 3.5 03:26:03 INFO - moznetwork == 0.27 03:26:03 INFO - mozprocess == 0.25 03:26:03 INFO - mozprofile == 0.28 03:26:03 INFO - mozrunner == 6.13 03:26:03 INFO - mozscreenshot == 0.1 03:26:03 INFO - mozsystemmonitor == 0.3 03:26:03 INFO - moztest == 0.8 03:26:03 INFO - mozversion == 1.4 03:26:03 INFO - psutil == 3.1.1 03:26:03 INFO - requests == 1.2.3 03:26:03 INFO - wsgiref == 0.1.2 03:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26: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')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:03 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:26:03 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 03:26:03 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 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:04 INFO - Installing collected packages: simplejson 03:26:04 INFO - Running setup.py install for simplejson 03:26:04 INFO - building 'simplejson._speedups' extension 03:26:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:26:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:26:05 INFO - Successfully installed simplejson 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:05 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')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 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')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 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 0x13491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', '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 03:26:05 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 03:26:05 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 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Running post-action listener: _resource_record_post_action 03:26:05 INFO - Running post-action listener: _start_resource_monitoring 03:26:05 INFO - Starting resource monitoring. 03:26:05 INFO - [mozharness: 2017-09-12 10:26:05.917060Z] Finished create-virtualenv step (success) 03:26:05 INFO - [mozharness: 2017-09-12 10:26:05.917579Z] Running install step. 03:26:05 INFO - Running pre-action listener: _resource_record_pre_action 03:26:05 INFO - Running main action method: install 03:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:06 INFO - Reading from file tmpfile_stdout 03:26:06 INFO - Output received: 03:26:06 INFO - Usage: mozinstall [options] installer 03:26:06 INFO - Options: 03:26:06 INFO - -h, --help show this help message and exit 03:26:06 INFO - -d DEST, --destination=DEST 03:26:06 INFO - Directory to install application into. [default: 03:26:06 INFO - "/builds/slave/test"] 03:26:06 INFO - --app=APP Application being installed. [default: firefox] 03:26:06 INFO - mkdir: /builds/slave/test/build/application 03:26:06 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'] 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:26:22 INFO - Reading from file tmpfile_stdout 03:26:22 INFO - Output received: 03:26:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:22 INFO - Running post-action listener: _resource_record_post_action 03:26:22 INFO - [mozharness: 2017-09-12 10:26:22.834627Z] Finished install step (success) 03:26:22 INFO - [mozharness: 2017-09-12 10:26:22.834772Z] Running setup-mitmproxy step. 03:26:22 INFO - Running pre-action listener: _resource_record_pre_action 03:26:22 INFO - Running main action method: setup_mitmproxy 03:26:22 INFO - Skipping: mitmproxy is not required 03:26:22 INFO - Running post-action listener: _resource_record_post_action 03:26:22 INFO - [mozharness: 2017-09-12 10:26:22.835521Z] Finished setup-mitmproxy step (success) 03:26:22 INFO - [mozharness: 2017-09-12 10:26:22.835741Z] Running run-tests step. 03:26:22 INFO - Running pre-action listener: _resource_record_pre_action 03:26:22 INFO - Running pre-action listener: _set_gcov_prefix 03:26:22 INFO - Running main action method: run_tests 03:26:22 WARNING - Try message not found. 03:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:22 INFO - Python 2.7.3 03:26:22 INFO - Return code: 0 03:26:22 INFO - grabbing minidump binary from tooltool 03:26:22 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')]} 03:26:22 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 0x16b9090>, '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 0x16b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:22 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 03:26:22 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 03:26:22 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 03:26:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:22 INFO - Return code: 0 03:26:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:22 INFO - ENV: RUST_BACKTRACE is now full 03:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:22 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:26:22 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:26:22 INFO - Using env: {'DISPLAY': ':0', 03:26:22 INFO - 'HOME': '/home/cltbld', 03:26:22 INFO - 'LANG': 'en_US.UTF-8', 03:26:22 INFO - 'LANGUAGE': 'en_US:en', 03:26:22 INFO - 'LOGNAME': 'cltbld', 03:26:22 INFO - 'MAIL': '/var/mail/cltbld', 03:26:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:22 INFO - 'MOZ_NO_REMOTE': '1', 03:26:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:22 INFO - 'NO_EM_RESTART': '1', 03:26:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:22 INFO - 'PWD': '/builds/slave/test', 03:26:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:22 INFO - 'RUST_BACKTRACE': 'full', 03:26:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:22 INFO - 'SHELL': '/bin/bash', 03:26:22 INFO - 'SHLVL': '1', 03:26:22 INFO - 'TERM': 'linux', 03:26:22 INFO - 'TMOUT': '86400', 03:26:22 INFO - 'USER': 'cltbld', 03:26:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:22 INFO - '_': '/tools/buildbot/bin/python'} 03:26:22 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:26:23 INFO - mozversion application_buildid: 20170912093323 03:26:23 INFO - mozversion application_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:23 INFO - mozversion application_display_name: Nightly 03:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:23 INFO - mozversion application_name: Firefox 03:26:23 INFO - mozversion application_remotingname: firefox 03:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:23 INFO - mozversion application_vendor: Mozilla 03:26:23 INFO - mozversion application_version: 57.0a1 03:26:23 INFO - mozversion platform_buildid: 20170912093323 03:26:23 INFO - mozversion platform_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:23 INFO - mozversion platform_version: 57.0a1 03:26:23 INFO - using testdate: 1505211983 03:26:23 INFO - actual date: 1505211983 03:26:23 INFO - starting webserver on 'localhost:48426' 03:26:23 INFO - SUITE-START | Running 2 tests 03:26:23 INFO - TEST-START | dromaeo_css 03:26:23 INFO - Initialising browser for dromaeo_css test... 03:26:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48426/getInfo.html -profile /tmp/tmpqLpGCR/profile 03:26:23 INFO - TEST-INFO | started process 15132 (/builds/slave/test/build/application/firefox/firefox http://localhost:48426/getInfo.html) 03:26:29 INFO - TEST-INFO | 15132: exit 0 03:26:29 INFO - Browser initialized. 03:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:29 INFO - Using env: {'DISPLAY': ':0', 03:26:29 INFO - 'HOME': '/home/cltbld', 03:26:29 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:29 INFO - 'LANG': 'en_US.UTF-8', 03:26:29 INFO - 'LANGUAGE': 'en_US:en', 03:26:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:29 INFO - 'LOGNAME': 'cltbld', 03:26:29 INFO - 'MAIL': '/var/mail/cltbld', 03:26:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:29 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:29 INFO - 'MOZ_NO_REMOTE': '1', 03:26:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:29 INFO - 'NO_EM_RESTART': '1', 03:26:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:29 INFO - 'PWD': '/builds/slave/test', 03:26:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:29 INFO - 'RUST_BACKTRACE': 'full', 03:26:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:29 INFO - 'SHELL': '/bin/bash', 03:26:29 INFO - 'SHLVL': '1', 03:26:29 INFO - 'TERM': 'linux', 03:26:29 INFO - 'TMOUT': '86400', 03:26:29 INFO - 'USER': 'cltbld', 03:26:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:29 INFO - '_': '/tools/buildbot/bin/python'} 03:26:29 INFO - TEST-INFO | started process 15334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqLpGCR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:30 INFO - PID 15334 | 03:26:30 INFO - PID 15334 | (/builds/slave/test/build/application/firefox/firefox:15385): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:30 INFO - PID 15334 | 03:26:40 INFO - PID 15334 | RSS: Main: 167137280 03:26:40 INFO - PID 15334 | 03:29:38 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48426/tests/dromaeo/cssquery-ext.html) 03:29:39 INFO - PID 15334 | RSS: Main: 174141440 03:29:39 INFO - PID 15334 | 03:32:41 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-ext.html (next: http://localhost:48426/tests/dromaeo/cssquery-jquery.html) 03:32:41 INFO - PID 15334 | RSS: Main: 170090496 03:32:41 INFO - PID 15334 | 03:35:43 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48426/tests/dromaeo/cssquery-mootools.html) 03:35:44 INFO - PID 15334 | RSS: Main: 171995136 03:35:44 INFO - PID 15334 | 03:38:45 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48426/tests/dromaeo/cssquery-prototype.html) 03:38:46 INFO - PID 15334 | RSS: Main: 171261952 03:38:46 INFO - PID 15334 | 03:41:49 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48426/tests/dromaeo/cssquery-yui.html) 03:41:50 INFO - PID 15334 | RSS: Main: 172609536 03:41:50 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | Cycle 1(1): loaded http://localhost:48426/tests/dromaeo/cssquery-yui.html (next: http://localhost:48426/tests/dromaeo/cssquery-dojo.html) 03:44:52 INFO - PID 15334 | RSS: Main: 175452160 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | __start_tp_report 03:44:52 INFO - PID 15334 | _x_x_mozilla_page_load 03:44:52 INFO - PID 15334 | _x_x_mozilla_page_load_details 03:44:52 INFO - PID 15334 | |i|pagename|runs| 03:44:52 INFO - PID 15334 | |0;dojo.html;3045.8477076146187;3059.6940305969406;3101.8759249630016;3111.6888311168887;3112.7976681515684;6143.26280846298;6273.5294852886045;6303.054541818729;6342.302346741854;6396.520260980422;6212;6308.116863639083;6399.264084630269;6412.134361861147;6446.967765161179;5644.294463192101;5795.71021448928;5838.795642152526;5868.207791948096;5939.821805345847;5778.24882765242;5862;5895.322037965624;5931.644101353911;5961.701914904259;5595.7481913313995;5699.430056994288;5729.914051289234;5826.82519524415;5837.066069428914;5766.942330576682;5856.12158176277;5859.707014649251;5862.14998825168;5866.853328666774;5717.285339332583;5793.246877905845;5833.358330583633;5846.181534585162;5855.882882342372;6181.845453863644;6272.40412160844;6283.371662833726;6339.239291285029;6458.773942912023;6699.564528305693;6699.799006029827;6702.162229721285;6727.495437842133;6865.038894554767;6856.725730970755;6928.72285108595;6941.930580694179;6943.132108486439;6946.79159625212;6204.875902481925;6281.528885333618;6290.276618188876;6325.051242313643;6423.325550817191;6810.387065164159;6851.588904665736;6862.245153033163;6873.621950792754;6876.209235937831;6569.4744420447205;6679.632620205838;6770.390664840188;6780.423663988518;6784.3894049535775;6823.283555226729;6900.102986611709;6911.274316196827;6914.239433662394;6914.585124892523;6766.188057433041;6774.3225677431865;6796.694148763318;6876.621785801829;6887.104676392037;6569.605823650596;6668.199816022011;6783.050372947791;6795.728170873209;6884.173899132036;5349.117395629755;5364.91952620711;5368.489993450616;5372.435894231127;5374.5700343972385;4632.953670463319;4674.0885527322525;4686.062787442457;4694.7887345068875;4727.196376615983;5834.154047663065;5844.327902291206;5903.704814759245;5908.615939963888;5920.763169473173;6602.7028783704845;6724.260331363546;6811.182658081062;6866.313368663094;6874.518783685194;5880.14737863016;5892.734826932799;5897.292324920951;5909.468147866627;5912.260967379078;5834.411384217369;5845.210896528914;5858.589898707135;5911.231539899785;5926.348101708809;6540.215174179129;6592.340765923369;6593.40659340652;6689.464842812563;6693.1298931138645;6841.17905851301;6857.931420685729;6862.416694581017;6865.519413641197;6891.138607674041;6467.256265529524;6660.367265109807;6661.600303981777;6668.0331351954665;6683.933160668331;6686.699098540675;6707.3628005339415;6784.457243420416;6791.966040169767;6803.285655006351;6791;6817.42051925572;6841.315868413119;6918.827029324307;6921.134858142732;6615.140031795836;6629.5359324846795;6635.966820165868;6649.035889795856;6651.467882569286;6337.207849018872;6533.509986750918;6559.967200164159;6632.535722499379;6640.435562977201;6514.4788416925585;6560.803175904731;6588.868222635616;6591.011348297794;6595.043718660863;6570.671466426564;6624.370684784938;6651.534392592665;6736.831579210559;6756.729730810713;6436.967815160894;6455.935440645721;6466.321036291121;6468.223813142453;6489.902651460137 03:44:52 INFO - PID 15334 | |1;ext.html;835.8704400817876;866.2982983783136;886.5700135434313;888.2449917570062;889.2397000564517;39981.20037599246;40667.79666101669;41589.79205103974;41619.79190104053;41647.16705665885;41275.58724412755;41455;41516.37725434121;41530.58469415305;41936.58063419365;7690.077190737105;7797.688092476323;7816.531008139501;7822.37421006321;7828.5694286814205;7664.156942736295;7687.538747675129;7695.884561731578;7704.19105993871;7707.499012564165;7732.7680169595005;7754.224577542257;7842.921570784305;7844.960775196116;7846.05847298325;7767.145613982458;7777.3389261912525;7803.453758236926;7806.960965195138;7827.491213071161;7628.275313845232;7705.807354816118;7706.922930770676;7709.884351734729;7710.498817576896;37623.435648465296;37928.43107353392;37960.81019594912;37987;38033.23933521314;3436.9312613747584;3468.9479657805155;3481.791092534431;3484.094135524782;3487.232808782064;30680.2329941751;30706.53940190899;30707.38585228283;30709.846450767825;30718.23204419885;4966.55301022906;5130.204818253177;5144.768485418165;5166.535011848951;5176.2235664650225;179500.9999999987;179604;180170;180183.09908450374;180640;46343.536564634596;46414;46453.7677311618;46531.30203046957;46568;48125.75937120292;48379.758101209976;48399.75800120977;48524.27213591799;48624.513754862;15588.376464941502;16026.519204423887;16108.597285067734;16119.67760644804;16130.677386452206;13233.139845909986;13264;13269;13288.933555332162;13325.06724529293;13047.608571742863;13226.338683065807;13232.206067635972;13385.397657105454;13406.128601641058;5224.320838291073;5237.659552129176;5239.973800130975;5393.78424863009;5440.891182176334;986.127277359542;996.3722854601555;999.4303247149201;1009.7273736091361;1026.3636545341787;22160.89471500205;22543.43641408945;22738;22928.4267893304;23175.304740857802;1100.2298391126244;1106.397013627575;1108.7449886526144;1109.755853712182;1120.9439528023565;11870;12007;12047.337396443105;12056.63830085099;12121.878781212252;215203;215461;215921;216257;216335;50954.74522627363;53395.19907201395;56107;56509.71745141248;56610.71694641501;1424.5726282115531;1432.1836553164596;1433.240382597225;1448.9637759055897;1452.0343971259206;26441.33896652599;26661.066862659714;26828.195154145407;27173.320666983484;27268.45463090767;36921.6307836929;37175.442368363954;37252.25495490129;37293.627063729014;37383.43924841075;203280;204202;204614;204765;204817;32889;32967;33054;33178.5023224647;33330.83334583312;40367.3944890821;42289;42494.36258456064;42575.574244257165;42739;30764;30901.536476952413;31054.844725776227;31155.53266700956;31262.687373125977;30797.8460107698;30945.226369340948;31013.8449307752;31356.372872541964;31511.527327089654;35471.29057418889;35503.46744798779;35589.1102722434;35921;36009.81995090008;31035.84482077575;31201.687983120788;31310.843445782626;31322.373552529276;31352;22363.552728945655;22447.551048978603;22667.659985100567;22902.42743931415;22977.310680679606 03:44:52 INFO - PID 15334 | |2;jquery.html;554.5535843645866;563.754766676496;566.4420545762424;569.2429069337782;576.0897781505222;21816.563668726616;22491.775082249173;22584.774152258495;22611.773882261172;22697.773022269772;22023.008964596593;23176.65235021476;24160.637590436112;24386.390340241458;24396;6239.875202495959;6268.717907694165;6270.216222972129;6287.685615719196;6306.527010474209;6223.968880155616;6330.84172895679;6331.113644089831;6331.715072821711;6355.618662880219;6267.905981410283;6512.153420055386;6517.3482651734685;6520.576162549442;6529.053287273343;6478.54650174488;6523.608583485006;6524.217093948709;6525.641089740062;6538.215414150309;5780.335261444903;5982.282126144847;6015.639061656315;6030.185924900126;6031.577789554733;27920;28311.575326370123;28451;28454;28469.14950528209;2058.8455865810124;2089.362744362984;2101.2540548105353;2103.085157956294;2103.747550293959;19016.809831901643;19140.23439062436;19487.610247795106;19585.216591336328;19660.90169549143;2430.1288404360753;2430.21018169094;2436.427439551704;2445.4864478459544;2468.358226861011;117363;121190;122921;126011;131775.99999999904;14434.566962991126;14453.401494298114;14511.854881451261;14544.41822327095;14653.801082105325;22198;22279.665805012937;22291.554168916857;22341.888290558443;22380.104795807987;9526.85709714355;10100;10138.290319677551;10289.588416463408;10317.84523232152;9580.0898914603;9626;9631.229501639851;9694.272929530314;9708.223342132613;8685.002449436664;8732.170443807829;8948.8657670135;8952.14954579314;9224.169824715673;2572.356910772307;2584.4751596557744;2629.224378808256;2637.6702912135984;2658.9734102658726;931.417863835103;959.6833045095102;960.2941837749248;966.0243154414093;976.6044751875502;18281.542961425806;18288.90855545714;18533.443996679853;18598.07009649512;18879.716804247946;998.8551660009404;1015.2639336480992;1025.1388833379997;1025.261811495722;1041.1930753665818;10005.49972501372;10063.194944404577;10268.897311026943;10471.895281047093;10500;478959;487134;490641;491172;491766;98513;99014.5049274749;100890;101338.49330753299;101433.49283253684;1028.5885645741764;1060.8355704865758;1079.7246702090758;1127.261643623428;1169.4854264123758;18514.16686249095;18638.81361186371;18778.53053673669;18849.340273090376;19195.136218870462;52819.20771188358;53748;53773;54371.728141360625;56175.71912140413;65706;65785.34214657792;66034.67930641456;66395;66628;13590.93204533971;13751.762341389323;13894.583162505141;13921.373538191008;14021.158730476203;21708.782912170675;21825.454363641034;21951;21994.560108797414;22070.22754203595;17469.38857139994;17481.82518174853;17572.736408954133;17588.2085306159;17767.73348399749;15365.769513457532;15681.215939202766;16155;16383.426580070118;16620.91689541593;17784;17852.821471785635;17912.10439478047;18067.367642132464;18135.637287254445;13594.184348939096;13599.116057456235;13611.86388136106;13625.250611216477;13640.249786261851;17278.91360543189;17345.872518286273;17377.565560860574;17414.390496332566;17450.389236376664 03:44:52 INFO - PID 15334 | |3;mootools.html;1349.3253373313341;1418.524794193945;1419.4464158977994;1428.5000249912525;1429.8355689095752;12598.118131730782;13249.470021199153;13249.602511924633;15161.77257341138;15684;15118.546443606709;15410.075395476279;15418.922905385485;15428.768568471482;15463.149526776022;2666.773324267435;2714.6878109017516;2719.5376785946437;2720.5511090670016;2720.782337413012;2681.731826817322;2773.972260277402;2856.4001559672492;2859.6139521164687;2861.642294713161;2860.456513262484;2861.713828617132;2891.1182089462704;2894.0883621659214;2897.536394176932;2793.622860913771;2824.1951043952477;2829.688734239232;2840.2757296889163;2840.6165167702407;2668.7731542818883;2702.581099929514;2729.3040274729815;2730.7405796449307;2731.2489065506948;14845.554633361016;14930.1041937483;14998.850011499855;15001.774973375408;15079.623009424742;7906.80232994174;8196.42625016249;8197.590120494011;8199.22107399796;8199.918000819975;5344.545713614348;5454.5545131605695;5532.5573954083575;5588.748506317225;5598.608097433182;1900.9049547522707;1907.1036612791966;1910.8853468791779;1975.2790231565518;1978.673518869385;25283;25636.615450768255;25727.742722572722;25806.741932580622;26536.734632653814;6763.053172555846;6853.965730171317;6952;6966.268541803139;7002.579845209304;16736.163191840602;16736.497905062868;16769.832301676826;16783;16826.747598786027;7937.484063535851;8034.276915077554;8061.072976607765;8068.7175948841505;8075.878861817077;6311.211098612674;7297.635118244173;7415.962920185365;7424.183339832614;7469.402447804163;4760.190767569521;4940.654154209171;5413.918791218135;5436.728163591804;5512.448755124456;1563.9061656300657;1580.6443550201343;1590.9443169489011;1593.1954363046586;1606.7830842836302;762.8245503534218;786.563457281203;793.6428607126816;796.3668883237724;799.3285640062376;8038.638261278256;8144;8212.425130240827;8234.876476852853;8323.1260717625;985.4530735441755;986.0878687214441;992.2558081438921;996.2627655534852;998.9900100999042;4853.417589889165;4943.258511223274;5039.622028347889;5073.416557095981;5188.662736922163;21258.36224913255;21462.034208460656;21666.458338541346;22118.889405553193;22182.445438864157;20721.896390518254;21241.150353985668;21355;21822.890885545472;21860.781392186193;11505.654830355103;11620.941895290638;11646.24299420535;11689.298642081503;11690.941545292219;8416.789580260542;8614.65541378338;8640.956795216236;8678.349123815866;8720.607572659372;18211.089445527406;18486;18506.259749610403;18618.720719189492;19013.144408501375;18723.625527489647;18766.718499222796;18824;18954.52613684669;19113.13990870442;11612.94193529027;11732.530698772294;11878;11912.404379780803;11989.100817438553;13659.86340136586;13696.315184240948;13739.587812365646;13988.300584970508;14064.929675351557;10538.947305263424;10595.364278143335;10614.946925265323;10728.570857165625;10909.727256818644;10315.17478601695;10568;10650.73373165677;10740.248182627454;11019.559217631526;9674.08096230857;9764.902350976683;9866.703998880044;9882.308238423242;9882.407055576688;7102.18324892644;7104.715811367694;7148.678309475982;7217.819554511179;7226.205117436973;7307.634618268959;7324.377427918686;7356.154042285206;7429.182789893215;7444 03:44:52 INFO - PID 15334 | |4;prototype.html;501.74256449422126;509.8215624531412;522.3522831688706;525.1046964924801;530.3185406752324;6228.314885362606;6335.524835637329;6354.491640668747;6359.6184228946295;6376.9681151594295;6093.451589356957;6107.473131717071;6146.877062458748;6230.937690623093;6241.719122639481;5055.696658200502;5066.265391518227;5115.718635475047;5155.020546096249;5158.9484105158845;5046.511279172634;5117.923231151536;5138;5141.537261646451;5181.145111056671;4696.731882391752;4904.239842824368;4906.53387928148;4915.901681966358;4923.9753801230945;4851.345068415754;4868.683535570177;4880.902381952359;4900.58345040672;4916.385451818523;4406.7355958642265;4410.558944105596;4415.712978656409;4437.134758722051;4438.844640437569;6169.598976066542;6206.224221972254;6208.379162083756;6210;6237.87524249517;5577.135543990688;5580.553555715533;5581.776728930838;5626.184203290541;5662.150677398382;6509.804705858832;6544.083828264047;6554.377334153248;6573.1454910861285;6573.80278591643;4760.190767569521;4783.258594917794;4795.592374648159;4798.928016079762;4812.855614331575;6531.673416329165;6649.135612370409;6675.132232809704;6763.797086087426;6809.659517024129;4858.222684370484;4859;4862.124817532807;4874.415070191529;4919.557239848431;4949.579285760678;4949.65352425334;4959.2809042688605;4997.650164488524;5001.974990125026;5563.805266815642;5598.636088654306;5601.747921343549;5622.156676498558;5624.818788054473;6470.514711396664;6536.790693721677;6544.280129185786;6608.966955165193;6656.800295991128;1681.5039563328603;1685.0311071133901;1693.7290033594566;1698.524413164316;1702.7445883117632;1123.7864805686893;1181.9113566482376;1194.9761004779855;1198.5924785572947;1224.4857159992825;5505.229267902497;5536.889262214733;5614.887702245932;5642.943570564324;5674.347450043298;6609.86780264392;6661.9000714989315;6666.466682665472;6673.766418175341;6686.565373250821;5645.5483561314995;5677.829665110054;5722.799702010409;5732.398098199712;5738.454846789632;3476.704480119168;3482.2861313430685;3515.8417871195857;3540.274243780019;3542.539469868952;6369.280294320508;6443.96778016107;6451.548391612542;6453.128827608307;6474.061261117112;6706;6767.007465595322;6902.892778796608;6918.342757438036;6931.37617614407;6385.329540398191;6439.259485159173;6458.354164583598;6473.708683109271;6501.009535613671;6636.568623039487;6644.837153498215;6646;6661.766838160641;6665.50008749336;6693.631850248283;6711.798646040626;6751.358620931003;6765.797026089225;6769.492288078315;6379.808605741835;6416.647084410402;6440.162778838721;6553;6564.671766411565;4864.246041863516;4868.172410690262;4870.805167793249;4872.610191184767;4905;6432.935670643234;6497.83039052975;6742.190937087581;6773.966130169515;6832.726690932506;6340.587861788969;6348.460380867493;6358.332375100733;6434.935650643433;6545.476361890942;6403.839904002437;6436.710348034256;6437.25971513282;6469.45009674183;6483.351664833479;6255.78104766331;6300.306966233802;6323.336049714898;6360.268569114426;6374.3306952771145;6414.166158399565;6531.542792004514;6536.8755154574;6600.339966003361;6621.801345959629;6252.999520076766;6273.560850740404;6301.464375528131;6329.525285603506;6356.396142366468 03:44:52 INFO - PID 15334 | |5;yui.html;909.4906852162785;911.6809116809115;932.3054324528227;933.57055754353;940.501534186881;16470.341186352547;17233.05218212999;17260.395886143986;17277.445029947303;17314.48056558304;16109;16239.106849123293;16249.675006499863;16279.348826046944;16309.429169979054;935.4340623922548;959.5442164971653;962.5524131278954;962.8988956159608;963.0754475703299;980.745006298364;986.0927946289431;986.1075726467558;987.7777500062465;988.3378136648427;978.0806042320196;1008.2135933971514;1012.7721262715867;1020;1027.2757705817419;990.6037584965999;991.9832172023662;1007.6070332570304;1013.9594416223342;1014.0366651680932;716.7383904874683;730.8026832755179;740.8962745215674;744.2148533297369;749.0786332810619;17052.14739263032;17338.046407447586;17356.47930562085;17405.1297435129;17445.47663570095;21230;21648.78351216499;21699.240526581652;21844;22056.33830985073;16691.33234670624;16728.16359182048;16763.832361676472;16765;17029.829701702947;3756.492873462075;3775.263823554408;3785.545734511876;3785.659290663826;3787.696984241254;100205;116143;129020.3548982249;131262;136340.31829840786;17473.82526174722;17815.554611134827;17911.73132403015;17911.73132403015;17953.551161221076;30697;31199;31797.682023179474;32031.35937281288;32068.83965580204;8789.648414063493;8803.955980220186;8838.690645827364;8853.955730221307;8874.201321880933;3999.7800120993043;4095.8361665533043;4137.482814648169;4190.559991200941;4199.706020578591;5196.870078248074;5290.338707661543;5293.20601909709;5297.841064768063;5308.416074231832;1025.5948900184535;1056.0864851903048;1065.4406436620836;1066.7439814444479;1068.3803394031443;619.916311297978;624.7188765055743;629.6096420219493;632.3107812484322;650.1710319342781;10811.027007569357;10994.560217591206;11105.889880922761;11427.371494567713;11937.98527125204;669.7521916890685;676.7394553097093;679.4123083532808;686.9793906182822;690.4303949241895;5124.8206312778875;5162.716050617177;5192.324997750344;5193.013327467845;5211.114110601206;118608.40695796638;119287;121879;125520.37239813742;125589;86696;86754.56622716846;106263;111898;112082.43958780153;90314;92036.53981730048;96194;97846.51076744571;98836.50581747045;11091.38997355121;11170.664880053611;11392.202545821712;11758.529658813552;12194.085443591588;42118;42180.57819421766;43499.78250108856;43545.56454435415;44830.77584612056;77055;78635.52257217317;78809.60595196988;79514;81349.59325203336;14984.100953942798;15230.867678524794;15239.923800380928;15253.313600888208;15313;18958.905205473886;19032.333868315098;19134.521636959187;19194.616107677488;19233.51916202106;14520.782188267396;14673.119612823264;14759.852401476277;14852.85147148558;14869.330880110205;16046.598835029217;16144.67710645757;16261.674766504368;16284.348626054825;16320.836791631931;15627.374905004128;15769.053856768172;15803.209839508208;15845.286962086964;15871.365145394517;12660.17708848922;12902.09685322056;13038.739225215631;13092.934535327262;13288.40202190923;11687.240329378563;11716.70708232267;11726.648200553997;11770.234934729215;11985.880141198826 03:44:52 INFO - PID 15334 | __end_tp_report 03:44:52 INFO - PID 15334 | __start_cc_report 03:44:52 INFO - PID 15334 | _x_x_mozilla_cycle_collect,368 03:44:52 INFO - PID 15334 | __end_cc_report 03:44:52 INFO - PID 15334 | __startTimestamp1505213092347__endTimestamp 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | ------- Summary: start ------- 03:44:52 INFO - PID 15334 | Number of tests: 6 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#0] dojo.html Cycles:165 Average:6248.81 Median:6514.48 stddev:763.24 (11.7%) stddev-sans-first:723.04 03:44:52 INFO - PID 15334 | Values: 3045.8 3059.7 3101.9 3111.7 3112.8 6143.3 6273.5 6303.1 6342.3 6396.5 6212.0 6308.1 6399.3 6412.1 6447.0 5644.3 5795.7 5838.8 5868.2 5939.8 5778.2 5862.0 5895.3 5931.6 5961.7 5595.7 5699.4 5729.9 5826.8 5837.1 5766.9 5856.1 5859.7 5862.1 5866.9 5717.3 5793.2 5833.4 5846.2 5855.9 6181.8 6272.4 6283.4 6339.2 6458.8 6699.6 6699.8 6702.2 6727.5 6865.0 6856.7 6928.7 6941.9 6943.1 6946.8 6204.9 6281.5 6290.3 6325.1 6423.3 6810.4 6851.6 6862.2 6873.6 6876.2 6569.5 6679.6 6770.4 6780.4 6784.4 6823.3 6900.1 6911.3 6914.2 6914.6 6766.2 6774.3 6796.7 6876.6 6887.1 6569.6 6668.2 6783.1 6795.7 6884.2 5349.1 5364.9 5368.5 5372.4 5374.6 4633.0 4674.1 4686.1 4694.8 4727.2 5834.2 5844.3 5903.7 5908.6 5920.8 6602.7 6724.3 6811.2 6866.3 6874.5 5880.1 5892.7 5897.3 5909.5 5912.3 5834.4 5845.2 5858.6 5911.2 5926.3 6540.2 6592.3 6593.4 6689.5 6693.1 6841.2 6857.9 6862.4 6865.5 6891.1 6467.3 6660.4 6661.6 6668.0 6683.9 6686.7 6707.4 6784.5 6792.0 6803.3 6791.0 6817.4 6841.3 6918.8 6921.1 6615.1 6629.5 6636.0 6649.0 6651.5 6337.2 6533.5 6560.0 6632.5 6640.4 6514.5 6560.8 6588.9 6591.0 6595.0 6570.7 6624.4 6651.5 6736.8 6756.7 6437.0 6455.9 6466.3 6468.2 6489.9 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#1] ext.html Cycles:180 Average:36844.86 Median:3485.66 stddev:51913.43 (1489.3%) stddev-sans-first:51988.65 03:44:52 INFO - PID 15334 | Values: 835.9 866.3 886.6 888.2 889.2 39981.2 40667.8 41589.8 41619.8 41647.2 41275.6 41455.0 41516.4 41530.6 41936.6 7690.1 7797.7 7816.5 7822.4 7828.6 7664.2 7687.5 7695.9 7704.2 7707.5 7732.8 7754.2 7842.9 7845.0 7846.1 7767.1 7777.3 7803.5 7807.0 7827.5 7628.3 7705.8 7706.9 7709.9 7710.5 37623.4 37928.4 37960.8 37987.0 38033.2 3436.9 3468.9 3481.8 3484.1 3487.2 30680.2 30706.5 30707.4 30709.8 30718.2 4966.6 5130.2 5144.8 5166.5 5176.2 179501.0 179604.0 180170.0 180183.1 180640.0 46343.5 46414.0 46453.8 46531.3 46568.0 48125.8 48379.8 48399.8 48524.3 48624.5 15588.4 16026.5 16108.6 16119.7 16130.7 13233.1 13264.0 13269.0 13288.9 13325.1 13047.6 13226.3 13232.2 13385.4 13406.1 5224.3 5237.7 5240.0 5393.8 5440.9 986.1 996.4 999.4 1009.7 1026.4 22160.9 22543.4 22738.0 22928.4 23175.3 1100.2 1106.4 1108.7 1109.8 1120.9 11870.0 12007.0 12047.3 12056.6 12121.9 215203.0 215461.0 215921.0 216257.0 216335.0 50954.7 53395.2 56107.0 56509.7 56610.7 1424.6 1432.2 1433.2 1449.0 1452.0 26441.3 26661.1 26828.2 27173.3 27268.5 36921.6 37175.4 37252.3 37293.6 37383.4 203280.0 204202.0 204614.0 204765.0 204817.0 32889.0 32967.0 33054.0 33178.5 33330.8 40367.4 42289.0 42494.4 42575.6 42739.0 30764.0 30901.5 31054.8 31155.5 31262.7 30797.8 30945.2 31013.8 31356.4 31511.5 35471.3 35503.5 35589.1 35921.0 36009.8 31035.8 31201.7 31310.8 31322.4 31352.0 22363.6 22447.6 22667.7 22902.4 22977.3 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#2] jquery.html Cycles:180 Average:33326.04 Median:22316.72 stddev:81386.52 (364.7%) stddev-sans-first:81577.64 03:44:52 INFO - PID 15334 | Values: 554.6 563.8 566.4 569.2 576.1 21816.6 22491.8 22584.8 22611.8 22697.8 22023.0 23176.7 24160.6 24386.4 24396.0 6239.9 6268.7 6270.2 6287.7 6306.5 6224.0 6330.8 6331.1 6331.7 6355.6 6267.9 6512.2 6517.3 6520.6 6529.1 6478.5 6523.6 6524.2 6525.6 6538.2 5780.3 5982.3 6015.6 6030.2 6031.6 27920.0 28311.6 28451.0 28454.0 28469.1 2058.8 2089.4 2101.3 2103.1 2103.7 19016.8 19140.2 19487.6 19585.2 19660.9 2430.1 2430.2 2436.4 2445.5 2468.4 117363.0 121190.0 122921.0 126011.0 131776.0 14434.6 14453.4 14511.9 14544.4 14653.8 22198.0 22279.7 22291.6 22341.9 22380.1 9526.9 10100.0 10138.3 10289.6 10317.8 9580.1 9626.0 9631.2 9694.3 9708.2 8685.0 8732.2 8948.9 8952.1 9224.2 2572.4 2584.5 2629.2 2637.7 2659.0 931.4 959.7 960.3 966.0 976.6 18281.5 18288.9 18533.4 18598.1 18879.7 998.9 1015.3 1025.1 1025.3 1041.2 10005.5 10063.2 10268.9 10471.9 10500.0 478959.0 487134.0 490641.0 491172.0 491766.0 98513.0 99014.5 100890.0 101338.5 101433.5 1028.6 1060.8 1079.7 1127.3 1169.5 18514.2 18638.8 18778.5 18849.3 19195.1 52819.2 53748.0 53773.0 54371.7 56175.7 65706.0 65785.3 66034.7 66395.0 66628.0 13590.9 13751.8 13894.6 13921.4 14021.2 21708.8 21825.5 21951.0 21994.6 22070.2 17469.4 17481.8 17572.7 17588.2 17767.7 15365.8 15681.2 16155.0 16383.4 16620.9 17784.0 17852.8 17912.1 18067.4 18135.6 13594.2 13599.1 13611.9 13625.3 13640.2 17278.9 17345.9 17377.6 17414.4 17450.4 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#3] mootools.html Cycles:180 Average:9274.95 Median:2720.04 stddev:6555.96 (241.0%) stddev-sans-first:6547.30 03:44:52 INFO - PID 15334 | Values: 1349.3 1418.5 1419.4 1428.5 1429.8 12598.1 13249.5 13249.6 15161.8 15684.0 15118.5 15410.1 15418.9 15428.8 15463.1 2666.8 2714.7 2719.5 2720.6 2720.8 2681.7 2774.0 2856.4 2859.6 2861.6 2860.5 2861.7 2891.1 2894.1 2897.5 2793.6 2824.2 2829.7 2840.3 2840.6 2668.8 2702.6 2729.3 2730.7 2731.2 14845.6 14930.1 14998.9 15001.8 15079.6 7906.8 8196.4 8197.6 8199.2 8199.9 5344.5 5454.6 5532.6 5588.7 5598.6 1900.9 1907.1 1910.9 1975.3 1978.7 25283.0 25636.6 25727.7 25806.7 26536.7 6763.1 6854.0 6952.0 6966.3 7002.6 16736.2 16736.5 16769.8 16783.0 16826.7 7937.5 8034.3 8061.1 8068.7 8075.9 6311.2 7297.6 7416.0 7424.2 7469.4 4760.2 4940.7 5413.9 5436.7 5512.4 1563.9 1580.6 1590.9 1593.2 1606.8 762.8 786.6 793.6 796.4 799.3 8038.6 8144.0 8212.4 8234.9 8323.1 985.5 986.1 992.3 996.3 999.0 4853.4 4943.3 5039.6 5073.4 5188.7 21258.4 21462.0 21666.5 22118.9 22182.4 20721.9 21241.2 21355.0 21822.9 21860.8 11505.7 11620.9 11646.2 11689.3 11690.9 8416.8 8614.7 8641.0 8678.3 8720.6 18211.1 18486.0 18506.3 18618.7 19013.1 18723.6 18766.7 18824.0 18954.5 19113.1 11612.9 11732.5 11878.0 11912.4 11989.1 13659.9 13696.3 13739.6 13988.3 14064.9 10538.9 10595.4 10614.9 10728.6 10909.7 10315.2 10568.0 10650.7 10740.2 11019.6 9674.1 9764.9 9866.7 9882.3 9882.4 7102.2 7104.7 7148.7 7217.8 7226.2 7307.6 7324.4 7356.2 7429.2 7444.0 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#4] prototype.html Cycles:180 Average:5465.73 Median:6209.19 stddev:1543.54 (24.9%) stddev-sans-first:1502.23 03:44:52 INFO - PID 15334 | Values: 501.7 509.8 522.4 525.1 530.3 6228.3 6335.5 6354.5 6359.6 6377.0 6093.5 6107.5 6146.9 6230.9 6241.7 5055.7 5066.3 5115.7 5155.0 5158.9 5046.5 5117.9 5138.0 5141.5 5181.1 4696.7 4904.2 4906.5 4915.9 4924.0 4851.3 4868.7 4880.9 4900.6 4916.4 4406.7 4410.6 4415.7 4437.1 4438.8 6169.6 6206.2 6208.4 6210.0 6237.9 5577.1 5580.6 5581.8 5626.2 5662.2 6509.8 6544.1 6554.4 6573.1 6573.8 4760.2 4783.3 4795.6 4798.9 4812.9 6531.7 6649.1 6675.1 6763.8 6809.7 4858.2 4859.0 4862.1 4874.4 4919.6 4949.6 4949.7 4959.3 4997.7 5002.0 5563.8 5598.6 5601.7 5622.2 5624.8 6470.5 6536.8 6544.3 6609.0 6656.8 1681.5 1685.0 1693.7 1698.5 1702.7 1123.8 1181.9 1195.0 1198.6 1224.5 5505.2 5536.9 5614.9 5642.9 5674.3 6609.9 6661.9 6666.5 6673.8 6686.6 5645.5 5677.8 5722.8 5732.4 5738.5 3476.7 3482.3 3515.8 3540.3 3542.5 6369.3 6444.0 6451.5 6453.1 6474.1 6706.0 6767.0 6902.9 6918.3 6931.4 6385.3 6439.3 6458.4 6473.7 6501.0 6636.6 6644.8 6646.0 6661.8 6665.5 6693.6 6711.8 6751.4 6765.8 6769.5 6379.8 6416.6 6440.2 6553.0 6564.7 4864.2 4868.2 4870.8 4872.6 4905.0 6432.9 6497.8 6742.2 6774.0 6832.7 6340.6 6348.5 6358.3 6434.9 6545.5 6403.8 6436.7 6437.3 6469.5 6483.4 6255.8 6300.3 6323.3 6360.3 6374.3 6414.2 6531.5 6536.9 6600.3 6621.8 6253.0 6273.6 6301.5 6329.5 6356.4 03:44:52 INFO - PID 15334 | 03:44:52 INFO - PID 15334 | [#5] yui.html Cycles:180 Average:24032.35 Median:18995.62 stddev:34163.23 (179.8%) stddev-sans-first:34214.95 03:44:52 INFO - PID 15334 | Values: 909.5 911.7 932.3 933.6 940.5 16470.3 17233.1 17260.4 17277.4 17314.5 16109.0 16239.1 16249.7 16279.3 16309.4 935.4 959.5 962.6 962.9 963.1 980.7 986.1 986.1 987.8 988.3 978.1 1008.2 1012.8 1020.0 1027.3 990.6 992.0 1007.6 1014.0 1014.0 716.7 730.8 740.9 744.2 749.1 17052.1 17338.0 17356.5 17405.1 17445.5 21230.0 21648.8 21699.2 21844.0 22056.3 16691.3 16728.2 16763.8 16765.0 17029.8 3756.5 3775.3 3785.5 3785.7 3787.7 100205.0 116143.0 129020.4 131262.0 136340.3 17473.8 17815.6 17911.7 17911.7 17953.6 30697.0 31199.0 31797.7 32031.4 32068.8 8789.6 8804.0 8838.7 8854.0 8874.2 3999.8 4095.8 4137.5 4190.6 4199.7 5196.9 5290.3 5293.2 5297.8 5308.4 1025.6 1056.1 1065.4 1066.7 1068.4 619.9 624.7 629.6 632.3 650.2 10811.0 10994.6 11105.9 11427.4 11938.0 669.8 676.7 679.4 687.0 690.4 5124.8 5162.7 5192.3 5193.0 5211.1 118608.4 119287.0 121879.0 125520.4 125589.0 86696.0 86754.6 106263.0 111898.0 112082.4 90314.0 92036.5 96194.0 97846.5 98836.5 11091.4 11170.7 11392.2 11758.5 12194.1 42118.0 42180.6 43499.8 43545.6 44830.8 77055.0 78635.5 78809.6 79514.0 81349.6 14984.1 15230.9 15239.9 15253.3 15313.0 18958.9 19032.3 19134.5 19194.6 19233.5 14520.8 14673.1 14759.9 14852.9 14869.3 16046.6 16144.7 16261.7 16284.3 16320.8 15627.4 15769.1 15803.2 15845.3 15871.4 12660.2 12902.1 13038.7 13092.9 13288.4 11687.2 11716.7 11726.6 11770.2 11985.9 03:44:52 INFO - PID 15334 | -------- Summary: end -------- 03:44:52 INFO - PID 15334 | 03:44:53 INFO - TEST-INFO | 15334: exit 0 03:44:53 INFO - TEST-OK | dromaeo_css | took 1109902ms 03:44:53 INFO - TEST-START | kraken 03:44:53 INFO - Initialising browser for kraken test... 03:44:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48426/getInfo.html -profile /tmp/tmp1Xu0Bn/profile 03:44:53 INFO - TEST-INFO | started process 15714 (/builds/slave/test/build/application/firefox/firefox http://localhost:48426/getInfo.html) 03:44:59 INFO - TEST-INFO | 15714: exit 0 03:44:59 INFO - Browser initialized. 03:44:59 INFO - Running cycle 1/1 for kraken test... 03:44:59 INFO - Using env: {'DISPLAY': ':0', 03:44:59 INFO - 'HOME': '/home/cltbld', 03:44:59 INFO - 'JSGC_DISABLE_POISONING': '1', 03:44:59 INFO - 'LANG': 'en_US.UTF-8', 03:44:59 INFO - 'LANGUAGE': 'en_US:en', 03:44:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:44:59 INFO - 'LOGNAME': 'cltbld', 03:44:59 INFO - 'MAIL': '/var/mail/cltbld', 03:44:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:59 INFO - 'MOZ_CRASHREPORTER': '1', 03:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:44:59 INFO - 'MOZ_NO_REMOTE': '1', 03:44:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:59 INFO - 'NO_EM_RESTART': '1', 03:44:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:59 INFO - 'PWD': '/builds/slave/test', 03:44:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:59 INFO - 'RUST_BACKTRACE': 'full', 03:44:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:59 INFO - 'SHELL': '/bin/bash', 03:44:59 INFO - 'SHLVL': '1', 03:44:59 INFO - 'TERM': 'linux', 03:44:59 INFO - 'TMOUT': '86400', 03:44:59 INFO - 'USER': 'cltbld', 03:44:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836', 03:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:59 INFO - '_': '/tools/buildbot/bin/python'} 03:44:59 INFO - TEST-INFO | started process 15920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Xu0Bn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:00 INFO - PID 15920 | 03:45:00 INFO - PID 15920 | (/builds/slave/test/build/application/firefox/firefox:15971): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:00 INFO - PID 15920 | 03:45:10 INFO - PID 15920 | RSS: Main: 167522304 03:45:10 INFO - PID 15920 | 03:45:13 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48426/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:14 INFO - PID 15920 | RSS: Main: 172843008 03:45:14 INFO - PID 15920 | 03:45:16 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48426/tests/kraken/driver.html?testName=audio-dft) 03:45:17 INFO - PID 15920 | RSS: Main: 172888064 03:45:17 INFO - PID 15920 | 03:45:20 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48426/tests/kraken/driver.html?testName=audio-fft) 03:45:21 INFO - PID 15920 | RSS: Main: 168493056 03:45:21 INFO - PID 15920 | 03:45:23 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48426/tests/kraken/driver.html?testName=audio-oscillator) 03:45:23 INFO - PID 15920 | RSS: Main: 168665088 03:45:23 INFO - PID 15920 | 03:45:25 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:26 INFO - PID 15920 | RSS: Main: 169156608 03:45:26 INFO - PID 15920 | 03:45:29 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48426/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:30 INFO - PID 15920 | RSS: Main: 171442176 03:45:30 INFO - PID 15920 | 03:45:34 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48426/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:34 INFO - PID 15920 | RSS: Main: 171773952 03:45:34 INFO - PID 15920 | 03:45:37 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48426/tests/kraken/driver.html?testName=json-parse-financial) 03:45:38 INFO - PID 15920 | RSS: Main: 171925504 03:45:38 INFO - PID 15920 | 03:45:39 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:40 INFO - PID 15920 | RSS: Main: 172048384 03:45:40 INFO - PID 15920 | 03:45:42 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:42 INFO - PID 15920 | RSS: Main: 172294144 03:45:42 INFO - PID 15920 | 03:45:44 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:45 INFO - PID 15920 | RSS: Main: 171913216 03:45:45 INFO - PID 15920 | 03:45:48 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:48 INFO - PID 15920 | RSS: Main: 172318720 03:45:48 INFO - PID 15920 | 03:45:51 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:52 INFO - PID 15920 | RSS: Main: 172494848 03:45:52 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | Cycle 1(1): loaded http://localhost:48426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48426/tests/kraken/driver.html?testName=ai-astar) 03:45:54 INFO - PID 15920 | RSS: Main: 174002176 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | __start_tp_report 03:45:54 INFO - PID 15920 | _x_x_mozilla_page_load 03:45:54 INFO - PID 15920 | _x_x_mozilla_page_load_details 03:45:54 INFO - PID 15920 | |i|pagename|runs| 03:45:54 INFO - PID 15920 | |0;ai-astar;107;107;107;108;109;111;107;107;108;107 03:45:54 INFO - PID 15920 | |1;audio-beat-detection;120;116;125;122;118;116;120;119;117;136 03:45:54 INFO - PID 15920 | |2;audio-dft;163;162;162;161;163;162;166;166;174;164 03:45:54 INFO - PID 15920 | |3;audio-fft;76;73;74;74;74;74;75;75;75;74 03:45:54 INFO - PID 15920 | |4;audio-oscillator;82;80;79;80;79;80;81;80;84;79 03:45:54 INFO - PID 15920 | |5;imaging-gaussian-blur;114;114;114;114;113;113;115;114;114;118 03:45:54 INFO - PID 15920 | |6;imaging-darkroom;148;147;148;149;148;149;148;147;149;149 03:45:54 INFO - PID 15920 | |7;imaging-desaturate;97;95;95;95;94;93;94;94;94;94 03:45:54 INFO - PID 15920 | |8;json-parse-financial;55;54;55;59;54;53;55;55;54;54 03:45:54 INFO - PID 15920 | |9;json-stringify-tinderbox;39;38;38;38;38;39;38;38;39;38 03:45:54 INFO - PID 15920 | |10;stanford-crypto-aes;75;73;74;77;76;80;75;77;78;73 03:45:54 INFO - PID 15920 | |11;stanford-crypto-ccm;111;122;112;112;117;114;115;118;118;113 03:45:54 INFO - PID 15920 | |12;stanford-crypto-pbkdf2;179;168;172;169;173;169;176;180;170;177 03:45:54 INFO - PID 15920 | |13;stanford-crypto-sha256-iterative;65;75;67;67;68;66;65;66;67;72 03:45:54 INFO - PID 15920 | __end_tp_report 03:45:54 INFO - PID 15920 | __start_cc_report 03:45:54 INFO - PID 15920 | _x_x_mozilla_cycle_collect,946 03:45:54 INFO - PID 15920 | __end_cc_report 03:45:54 INFO - PID 15920 | __startTimestamp1505213154547__endTimestamp 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | ------- Summary: start ------- 03:45:54 INFO - PID 15920 | Number of tests: 14 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#0] ai-astar Cycles:10 Average:107.80 Median:107.50 stddev:1.32 (1.2%) stddev-sans-first:1.36 03:45:54 INFO - PID 15920 | Values: 107.0 107.0 107.0 108.0 109.0 111.0 107.0 107.0 108.0 107.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:120.00 stddev:5.99 (5.0%) stddev-sans-first:6.34 03:45:54 INFO - PID 15920 | Values: 120.0 116.0 125.0 122.0 118.0 116.0 120.0 119.0 117.0 136.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.80 (2.3%) stddev-sans-first:4.00 03:45:54 INFO - PID 15920 | Values: 163.0 162.0 162.0 161.0 163.0 162.0 166.0 166.0 174.0 164.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:0.84 (1.1%) stddev-sans-first:0.67 03:45:54 INFO - PID 15920 | Values: 76.0 73.0 74.0 74.0 74.0 74.0 75.0 75.0 75.0 74.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:80.00 stddev:1.58 (2.0%) stddev-sans-first:1.56 03:45:54 INFO - PID 15920 | Values: 82.0 80.0 79.0 80.0 79.0 80.0 81.0 80.0 84.0 79.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 03:45:54 INFO - PID 15920 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 115.0 114.0 114.0 118.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:45:54 INFO - PID 15920 | Values: 148.0 147.0 148.0 149.0 148.0 149.0 148.0 147.0 149.0 149.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:1.08 (1.1%) stddev-sans-first:0.67 03:45:54 INFO - PID 15920 | Values: 97.0 95.0 95.0 95.0 94.0 93.0 94.0 94.0 94.0 94.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.62 (2.9%) stddev-sans-first:1.72 03:45:54 INFO - PID 15920 | Values: 55.0 54.0 55.0 59.0 54.0 53.0 55.0 55.0 54.0 54.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 03:45:54 INFO - PID 15920 | Values: 39.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.50 stddev:2.25 (2.9%) stddev-sans-first:2.37 03:45:54 INFO - PID 15920 | Values: 75.0 73.0 74.0 77.0 76.0 80.0 75.0 77.0 78.0 73.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:116.00 stddev:3.49 (3.0%) stddev-sans-first:3.35 03:45:54 INFO - PID 15920 | Values: 111.0 122.0 112.0 112.0 117.0 114.0 115.0 118.0 118.0 113.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.50 stddev:4.42 (2.5%) stddev-sans-first:4.18 03:45:54 INFO - PID 15920 | Values: 179.0 168.0 172.0 169.0 173.0 169.0 176.0 180.0 170.0 177.0 03:45:54 INFO - PID 15920 | 03:45:54 INFO - PID 15920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:3.22 (4.8%) stddev-sans-first:3.26 03:45:54 INFO - PID 15920 | Values: 65.0 75.0 67.0 67.0 68.0 66.0 65.0 66.0 67.0 72.0 03:45:54 INFO - PID 15920 | -------- Summary: end -------- 03:45:54 INFO - PID 15920 | 03:45:55 INFO - PID 15920 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:45:55 INFO - TEST-INFO | 15920: exit 0 03:45:55 INFO - TEST-OK | kraken | took 62229ms 03:45:55 INFO - SUITE-END | took 1172s 03:45:55 INFO - Completed test suite (00:19:32) 03:45:55 INFO - javascript benchmark 03:45:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8430.776885537887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.8477076146187, 3059.6940305969406, 3101.8759249630016, 3111.6888311168887, 3112.7976681515684, 6143.26280846298, 6273.5294852886045, 6303.054541818729, 6342.302346741854, 6396.520260980422, 6212.0, 6308.116863639083, 6399.264084630269, 6412.134361861147, 6446.967765161179, 5644.294463192101, 5795.71021448928, 5838.795642152526, 5868.207791948096, 5939.821805345847, 5778.24882765242, 5862.0, 5895.322037965624, 5931.644101353911, 5961.701914904259, 5595.7481913313995, 5699.430056994288, 5729.914051289234, 5826.82519524415, 5837.066069428914, 5766.942330576682, 5856.12158176277, 5859.707014649251, 5862.14998825168, 5866.853328666774, 5717.285339332583, 5793.246877905845, 5833.358330583633, 5846.181534585162, 5855.882882342372, 6181.845453863644, 6272.40412160844, 6283.371662833726, 6339.239291285029, 6458.773942912023, 6699.564528305693, 6699.799006029827, 6702.162229721285, 6727.495437842133, 6865.038894554767, 6856.725730970755, 6928.72285108595, 6941.930580694179, 6943.132108486439, 6946.79159625212, 6204.875902481925, 6281.528885333618, 6290.276618188876, 6325.051242313643, 6423.325550817191, 6810.387065164159, 6851.588904665736, 6862.245153033163, 6873.621950792754, 6876.209235937831, 6569.4744420447205, 6679.632620205838, 6770.390664840188, 6780.423663988518, 6784.3894049535775, 6823.283555226729, 6900.102986611709, 6911.274316196827, 6914.239433662394, 6914.585124892523, 6766.188057433041, 6774.3225677431865, 6796.694148763318, 6876.621785801829, 6887.104676392037, 6569.605823650596, 6668.199816022011, 6783.050372947791, 6795.728170873209, 6884.173899132036, 5349.117395629755, 5364.91952620711, 5368.489993450616, 5372.435894231127, 5374.5700343972385, 4632.953670463319, 4674.0885527322525, 4686.062787442457, 4694.7887345068875, 4727.196376615983, 5834.154047663065, 5844.327902291206, 5903.704814759245, 5908.615939963888, 5920.763169473173, 6602.7028783704845, 6724.260331363546, 6811.182658081062, 6866.313368663094, 6874.518783685194, 5880.14737863016, 5892.734826932799, 5897.292324920951, 5909.468147866627, 5912.260967379078, 5834.411384217369, 5845.210896528914, 5858.589898707135, 5911.231539899785, 5926.348101708809, 6540.215174179129, 6592.340765923369, 6593.40659340652, 6689.464842812563, 6693.1298931138645, 6841.17905851301, 6857.931420685729, 6862.416694581017, 6865.519413641197, 6891.138607674041, 6467.256265529524, 6660.367265109807, 6661.600303981777, 6668.0331351954665, 6683.933160668331, 6686.699098540675, 6707.3628005339415, 6784.457243420416, 6791.966040169767, 6803.285655006351, 6791.0, 6817.42051925572, 6841.315868413119, 6918.827029324307, 6921.134858142732, 6615.140031795836, 6629.5359324846795, 6635.966820165868, 6649.035889795856, 6651.467882569286, 6337.207849018872, 6533.509986750918, 6559.967200164159, 6632.535722499379, 6640.435562977201, 6514.4788416925585, 6560.803175904731, 6588.868222635616, 6591.011348297794, 6595.043718660863, 6570.671466426564, 6624.370684784938, 6651.534392592665, 6736.831579210559, 6756.729730810713, 6436.967815160894, 6455.935440645721, 6466.321036291121, 6468.223813142453, 6489.902651460137], "value": 6188.608316378151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.8704400817876, 866.2982983783136, 886.5700135434313, 888.2449917570062, 889.2397000564517, 39981.20037599246, 40667.79666101669, 41589.79205103974, 41619.79190104053, 41647.16705665885, 41275.58724412755, 41455.0, 41516.37725434121, 41530.58469415305, 41936.58063419365, 7690.077190737105, 7797.688092476323, 7816.531008139501, 7822.37421006321, 7828.5694286814205, 7664.156942736295, 7687.538747675129, 7695.884561731578, 7704.19105993871, 7707.499012564165, 7732.7680169595005, 7754.224577542257, 7842.921570784305, 7844.960775196116, 7846.05847298325, 7767.145613982458, 7777.3389261912525, 7803.453758236926, 7806.960965195138, 7827.491213071161, 7628.275313845232, 7705.807354816118, 7706.922930770676, 7709.884351734729, 7710.498817576896, 37623.435648465296, 37928.43107353392, 37960.81019594912, 37987.0, 38033.23933521314, 3436.9312613747584, 3468.9479657805155, 3481.791092534431, 3484.094135524782, 3487.232808782064, 30680.2329941751, 30706.53940190899, 30707.38585228283, 30709.846450767825, 30718.23204419885, 4966.55301022906, 5130.204818253177, 5144.768485418165, 5166.535011848951, 5176.2235664650225, 179500.9999999987, 179604.0, 180170.0, 180183.09908450374, 180640.0, 46343.536564634596, 46414.0, 46453.7677311618, 46531.30203046957, 46568.0, 48125.75937120292, 48379.758101209976, 48399.75800120977, 48524.27213591799, 48624.513754862, 15588.376464941502, 16026.519204423887, 16108.597285067734, 16119.67760644804, 16130.677386452206, 13233.139845909986, 13264.0, 13269.0, 13288.933555332162, 13325.06724529293, 13047.608571742863, 13226.338683065807, 13232.206067635972, 13385.397657105454, 13406.128601641058, 5224.320838291073, 5237.659552129176, 5239.973800130975, 5393.78424863009, 5440.891182176334, 986.127277359542, 996.3722854601555, 999.4303247149201, 1009.7273736091361, 1026.3636545341787, 22160.89471500205, 22543.43641408945, 22738.0, 22928.4267893304, 23175.304740857802, 1100.2298391126244, 1106.397013627575, 1108.7449886526144, 1109.755853712182, 1120.9439528023565, 11870.0, 12007.0, 12047.337396443105, 12056.63830085099, 12121.878781212252, 215203.0, 215461.0, 215921.0, 216257.0, 216335.0, 50954.74522627363, 53395.19907201395, 56107.0, 56509.71745141248, 56610.71694641501, 1424.5726282115531, 1432.1836553164596, 1433.240382597225, 1448.9637759055897, 1452.0343971259206, 26441.33896652599, 26661.066862659714, 26828.195154145407, 27173.320666983484, 27268.45463090767, 36921.6307836929, 37175.442368363954, 37252.25495490129, 37293.627063729014, 37383.43924841075, 203280.0, 204202.0, 204614.0, 204765.0, 204817.0, 32889.0, 32967.0, 33054.0, 33178.5023224647, 33330.83334583312, 40367.3944890821, 42289.0, 42494.36258456064, 42575.574244257165, 42739.0, 30764.0, 30901.536476952413, 31054.844725776227, 31155.53266700956, 31262.687373125977, 30797.8460107698, 30945.226369340948, 31013.8449307752, 31356.372872541964, 31511.527327089654, 35471.29057418889, 35503.46744798779, 35589.1102722434, 35921.0, 36009.81995090008, 31035.84482077575, 31201.687983120788, 31310.843445782626, 31322.373552529276, 31352.0, 22363.552728945655, 22447.551048978603, 22667.659985100567, 22902.42743931415, 22977.310680679606], "value": 16976.9513844931, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5535843645866, 563.754766676496, 566.4420545762424, 569.2429069337782, 576.0897781505222, 21816.563668726616, 22491.775082249173, 22584.774152258495, 22611.773882261172, 22697.773022269772, 22023.008964596593, 23176.65235021476, 24160.637590436112, 24386.390340241458, 24396.0, 6239.875202495959, 6268.717907694165, 6270.216222972129, 6287.685615719196, 6306.527010474209, 6223.968880155616, 6330.84172895679, 6331.113644089831, 6331.715072821711, 6355.618662880219, 6267.905981410283, 6512.153420055386, 6517.3482651734685, 6520.576162549442, 6529.053287273343, 6478.54650174488, 6523.608583485006, 6524.217093948709, 6525.641089740062, 6538.215414150309, 5780.335261444903, 5982.282126144847, 6015.639061656315, 6030.185924900126, 6031.577789554733, 27920.0, 28311.575326370123, 28451.0, 28454.0, 28469.14950528209, 2058.8455865810124, 2089.362744362984, 2101.2540548105353, 2103.085157956294, 2103.747550293959, 19016.809831901643, 19140.23439062436, 19487.610247795106, 19585.216591336328, 19660.90169549143, 2430.1288404360753, 2430.21018169094, 2436.427439551704, 2445.4864478459544, 2468.358226861011, 117363.0, 121190.0, 122921.0, 126011.0, 131775.99999999904, 14434.566962991126, 14453.401494298114, 14511.854881451261, 14544.41822327095, 14653.801082105325, 22198.0, 22279.665805012937, 22291.554168916857, 22341.888290558443, 22380.104795807987, 9526.85709714355, 10100.0, 10138.290319677551, 10289.588416463408, 10317.84523232152, 9580.0898914603, 9626.0, 9631.229501639851, 9694.272929530314, 9708.223342132613, 8685.002449436664, 8732.170443807829, 8948.8657670135, 8952.14954579314, 9224.169824715673, 2572.356910772307, 2584.4751596557744, 2629.224378808256, 2637.6702912135984, 2658.9734102658726, 931.417863835103, 959.6833045095102, 960.2941837749248, 966.0243154414093, 976.6044751875502, 18281.542961425806, 18288.90855545714, 18533.443996679853, 18598.07009649512, 18879.716804247946, 998.8551660009404, 1015.2639336480992, 1025.1388833379997, 1025.261811495722, 1041.1930753665818, 10005.49972501372, 10063.194944404577, 10268.897311026943, 10471.895281047093, 10500.0, 478959.0, 487134.0, 490641.0, 491172.0, 491766.0, 98513.0, 99014.5049274749, 100890.0, 101338.49330753299, 101433.49283253684, 1028.5885645741764, 1060.8355704865758, 1079.7246702090758, 1127.261643623428, 1169.4854264123758, 18514.16686249095, 18638.81361186371, 18778.53053673669, 18849.340273090376, 19195.136218870462, 52819.20771188358, 53748.0, 53773.0, 54371.728141360625, 56175.71912140413, 65706.0, 65785.34214657792, 66034.67930641456, 66395.0, 66628.0, 13590.93204533971, 13751.762341389323, 13894.583162505141, 13921.373538191008, 14021.158730476203, 21708.782912170675, 21825.454363641034, 21951.0, 21994.560108797414, 22070.22754203595, 17469.38857139994, 17481.82518174853, 17572.736408954133, 17588.2085306159, 17767.73348399749, 15365.769513457532, 15681.215939202766, 16155.0, 16383.426580070118, 16620.91689541593, 17784.0, 17852.821471785635, 17912.10439478047, 18067.367642132464, 18135.637287254445, 13594.184348939096, 13599.116057456235, 13611.86388136106, 13625.250611216477, 13640.249786261851, 17278.91360543189, 17345.872518286273, 17377.565560860574, 17414.390496332566, 17450.389236376664], "value": 11562.366694344244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.3253373313341, 1418.524794193945, 1419.4464158977994, 1428.5000249912525, 1429.8355689095752, 12598.118131730782, 13249.470021199153, 13249.602511924633, 15161.77257341138, 15684.0, 15118.546443606709, 15410.075395476279, 15418.922905385485, 15428.768568471482, 15463.149526776022, 2666.773324267435, 2714.6878109017516, 2719.5376785946437, 2720.5511090670016, 2720.782337413012, 2681.731826817322, 2773.972260277402, 2856.4001559672492, 2859.6139521164687, 2861.642294713161, 2860.456513262484, 2861.713828617132, 2891.1182089462704, 2894.0883621659214, 2897.536394176932, 2793.622860913771, 2824.1951043952477, 2829.688734239232, 2840.2757296889163, 2840.6165167702407, 2668.7731542818883, 2702.581099929514, 2729.3040274729815, 2730.7405796449307, 2731.2489065506948, 14845.554633361016, 14930.1041937483, 14998.850011499855, 15001.774973375408, 15079.623009424742, 7906.80232994174, 8196.42625016249, 8197.590120494011, 8199.22107399796, 8199.918000819975, 5344.545713614348, 5454.5545131605695, 5532.5573954083575, 5588.748506317225, 5598.608097433182, 1900.9049547522707, 1907.1036612791966, 1910.8853468791779, 1975.2790231565518, 1978.673518869385, 25283.0, 25636.615450768255, 25727.742722572722, 25806.741932580622, 26536.734632653814, 6763.053172555846, 6853.965730171317, 6952.0, 6966.268541803139, 7002.579845209304, 16736.163191840602, 16736.497905062868, 16769.832301676826, 16783.0, 16826.747598786027, 7937.484063535851, 8034.276915077554, 8061.072976607765, 8068.7175948841505, 8075.878861817077, 6311.211098612674, 7297.635118244173, 7415.962920185365, 7424.183339832614, 7469.402447804163, 4760.190767569521, 4940.654154209171, 5413.918791218135, 5436.728163591804, 5512.448755124456, 1563.9061656300657, 1580.6443550201343, 1590.9443169489011, 1593.1954363046586, 1606.7830842836302, 762.8245503534218, 786.563457281203, 793.6428607126816, 796.3668883237724, 799.3285640062376, 8038.638261278256, 8144.0, 8212.425130240827, 8234.876476852853, 8323.1260717625, 985.4530735441755, 986.0878687214441, 992.2558081438921, 996.2627655534852, 998.9900100999042, 4853.417589889165, 4943.258511223274, 5039.622028347889, 5073.416557095981, 5188.662736922163, 21258.36224913255, 21462.034208460656, 21666.458338541346, 22118.889405553193, 22182.445438864157, 20721.896390518254, 21241.150353985668, 21355.0, 21822.890885545472, 21860.781392186193, 11505.654830355103, 11620.941895290638, 11646.24299420535, 11689.298642081503, 11690.941545292219, 8416.789580260542, 8614.65541378338, 8640.956795216236, 8678.349123815866, 8720.607572659372, 18211.089445527406, 18486.0, 18506.259749610403, 18618.720719189492, 19013.144408501375, 18723.625527489647, 18766.718499222796, 18824.0, 18954.52613684669, 19113.13990870442, 11612.94193529027, 11732.530698772294, 11878.0, 11912.404379780803, 11989.100817438553, 13659.86340136586, 13696.315184240948, 13739.587812365646, 13988.300584970508, 14064.929675351557, 10538.947305263424, 10595.364278143335, 10614.946925265323, 10728.570857165625, 10909.727256818644, 10315.17478601695, 10568.0, 10650.73373165677, 10740.248182627454, 11019.559217631526, 9674.08096230857, 9764.902350976683, 9866.703998880044, 9882.308238423242, 9882.407055576688, 7102.18324892644, 7104.715811367694, 7148.678309475982, 7217.819554511179, 7226.205117436973, 7307.634618268959, 7324.377427918686, 7356.154042285206, 7429.182789893215, 7444.0], "value": 6674.625070233827, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.74256449422126, 509.8215624531412, 522.3522831688706, 525.1046964924801, 530.3185406752324, 6228.314885362606, 6335.524835637329, 6354.491640668747, 6359.6184228946295, 6376.9681151594295, 6093.451589356957, 6107.473131717071, 6146.877062458748, 6230.937690623093, 6241.719122639481, 5055.696658200502, 5066.265391518227, 5115.718635475047, 5155.020546096249, 5158.9484105158845, 5046.511279172634, 5117.923231151536, 5138.0, 5141.537261646451, 5181.145111056671, 4696.731882391752, 4904.239842824368, 4906.53387928148, 4915.901681966358, 4923.9753801230945, 4851.345068415754, 4868.683535570177, 4880.902381952359, 4900.58345040672, 4916.385451818523, 4406.7355958642265, 4410.558944105596, 4415.712978656409, 4437.134758722051, 4438.844640437569, 6169.598976066542, 6206.224221972254, 6208.379162083756, 6210.0, 6237.87524249517, 5577.135543990688, 5580.553555715533, 5581.776728930838, 5626.184203290541, 5662.150677398382, 6509.804705858832, 6544.083828264047, 6554.377334153248, 6573.1454910861285, 6573.80278591643, 4760.190767569521, 4783.258594917794, 4795.592374648159, 4798.928016079762, 4812.855614331575, 6531.673416329165, 6649.135612370409, 6675.132232809704, 6763.797086087426, 6809.659517024129, 4858.222684370484, 4859.0, 4862.124817532807, 4874.415070191529, 4919.557239848431, 4949.579285760678, 4949.65352425334, 4959.2809042688605, 4997.650164488524, 5001.974990125026, 5563.805266815642, 5598.636088654306, 5601.747921343549, 5622.156676498558, 5624.818788054473, 6470.514711396664, 6536.790693721677, 6544.280129185786, 6608.966955165193, 6656.800295991128, 1681.5039563328603, 1685.0311071133901, 1693.7290033594566, 1698.524413164316, 1702.7445883117632, 1123.7864805686893, 1181.9113566482376, 1194.9761004779855, 1198.5924785572947, 1224.4857159992825, 5505.229267902497, 5536.889262214733, 5614.887702245932, 5642.943570564324, 5674.347450043298, 6609.86780264392, 6661.9000714989315, 6666.466682665472, 6673.766418175341, 6686.565373250821, 5645.5483561314995, 5677.829665110054, 5722.799702010409, 5732.398098199712, 5738.454846789632, 3476.704480119168, 3482.2861313430685, 3515.8417871195857, 3540.274243780019, 3542.539469868952, 6369.280294320508, 6443.96778016107, 6451.548391612542, 6453.128827608307, 6474.061261117112, 6706.0, 6767.007465595322, 6902.892778796608, 6918.342757438036, 6931.37617614407, 6385.329540398191, 6439.259485159173, 6458.354164583598, 6473.708683109271, 6501.009535613671, 6636.568623039487, 6644.837153498215, 6646.0, 6661.766838160641, 6665.50008749336, 6693.631850248283, 6711.798646040626, 6751.358620931003, 6765.797026089225, 6769.492288078315, 6379.808605741835, 6416.647084410402, 6440.162778838721, 6553.0, 6564.671766411565, 4864.246041863516, 4868.172410690262, 4870.805167793249, 4872.610191184767, 4905.0, 6432.935670643234, 6497.83039052975, 6742.190937087581, 6773.966130169515, 6832.726690932506, 6340.587861788969, 6348.460380867493, 6358.332375100733, 6434.935650643433, 6545.476361890942, 6403.839904002437, 6436.710348034256, 6437.25971513282, 6469.45009674183, 6483.351664833479, 6255.78104766331, 6300.306966233802, 6323.336049714898, 6360.268569114426, 6374.3306952771145, 6414.166158399565, 6531.542792004514, 6536.8755154574, 6600.339966003361, 6621.801345959629, 6252.999520076766, 6273.560850740404, 6301.464375528131, 6329.525285603506, 6356.396142366468], "value": 5009.955174105567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.4906852162785, 911.6809116809115, 932.3054324528227, 933.57055754353, 940.501534186881, 16470.341186352547, 17233.05218212999, 17260.395886143986, 17277.445029947303, 17314.48056558304, 16109.0, 16239.106849123293, 16249.675006499863, 16279.348826046944, 16309.429169979054, 935.4340623922548, 959.5442164971653, 962.5524131278954, 962.8988956159608, 963.0754475703299, 980.745006298364, 986.0927946289431, 986.1075726467558, 987.7777500062465, 988.3378136648427, 978.0806042320196, 1008.2135933971514, 1012.7721262715867, 1020.0, 1027.2757705817419, 990.6037584965999, 991.9832172023662, 1007.6070332570304, 1013.9594416223342, 1014.0366651680932, 716.7383904874683, 730.8026832755179, 740.8962745215674, 744.2148533297369, 749.0786332810619, 17052.14739263032, 17338.046407447586, 17356.47930562085, 17405.1297435129, 17445.47663570095, 21230.0, 21648.78351216499, 21699.240526581652, 21844.0, 22056.33830985073, 16691.33234670624, 16728.16359182048, 16763.832361676472, 16765.0, 17029.829701702947, 3756.492873462075, 3775.263823554408, 3785.545734511876, 3785.659290663826, 3787.696984241254, 100205.0, 116143.0, 129020.3548982249, 131262.0, 136340.31829840786, 17473.82526174722, 17815.554611134827, 17911.73132403015, 17911.73132403015, 17953.551161221076, 30697.0, 31199.0, 31797.682023179474, 32031.35937281288, 32068.83965580204, 8789.648414063493, 8803.955980220186, 8838.690645827364, 8853.955730221307, 8874.201321880933, 3999.7800120993043, 4095.8361665533043, 4137.482814648169, 4190.559991200941, 4199.706020578591, 5196.870078248074, 5290.338707661543, 5293.20601909709, 5297.841064768063, 5308.416074231832, 1025.5948900184535, 1056.0864851903048, 1065.4406436620836, 1066.7439814444479, 1068.3803394031443, 619.916311297978, 624.7188765055743, 629.6096420219493, 632.3107812484322, 650.1710319342781, 10811.027007569357, 10994.560217591206, 11105.889880922761, 11427.371494567713, 11937.98527125204, 669.7521916890685, 676.7394553097093, 679.4123083532808, 686.9793906182822, 690.4303949241895, 5124.8206312778875, 5162.716050617177, 5192.324997750344, 5193.013327467845, 5211.114110601206, 118608.40695796638, 119287.0, 121879.0, 125520.37239813742, 125589.0, 86696.0, 86754.56622716846, 106263.0, 111898.0, 112082.43958780153, 90314.0, 92036.53981730048, 96194.0, 97846.51076744571, 98836.50581747045, 11091.38997355121, 11170.664880053611, 11392.202545821712, 11758.529658813552, 12194.085443591588, 42118.0, 42180.57819421766, 43499.78250108856, 43545.56454435415, 44830.77584612056, 77055.0, 78635.52257217317, 78809.60595196988, 79514.0, 81349.59325203336, 14984.100953942798, 15230.867678524794, 15239.923800380928, 15253.313600888208, 15313.0, 18958.905205473886, 19032.333868315098, 19134.521636959187, 19194.616107677488, 19233.51916202106, 14520.782188267396, 14673.119612823264, 14759.852401476277, 14852.85147148558, 14869.330880110205, 16046.598835029217, 16144.67710645757, 16261.674766504368, 16284.348626054825, 16320.836791631931, 15627.374905004128, 15769.053856768172, 15803.209839508208, 15845.286962086964, 15871.365145394517, 12660.17708848922, 12902.09685322056, 13038.739225215631, 13092.934535327262, 13288.40202190923, 11687.240329378563, 11716.70708232267, 11726.648200553997, 11770.234934729215, 11985.880141198826], "value": 8839.349411917952, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 108.0, 109.0, 111.0, 107.0, 107.0, 108.0, 107.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 125.0, 122.0, 118.0, 116.0, 120.0, 119.0, 117.0, 136.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 162.0, 166.0, 166.0, 174.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 74.0, 74.0, 74.0, 75.0, 75.0, 75.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 80.0, 79.0, 80.0, 81.0, 80.0, 84.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0, 118.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 148.0, 149.0, 148.0, 147.0, 149.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 59.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 77.0, 76.0, 80.0, 75.0, 77.0, 78.0, 73.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 112.0, 112.0, 117.0, 114.0, 115.0, 118.0, 118.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 168.0, 172.0, 169.0, 173.0, 169.0, 176.0, 180.0, 170.0, 177.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 67.0, 67.0, 68.0, 66.0, 65.0, 66.0, 67.0, 72.0], "value": 67.8, "unit": "score"}]}]} 03:45:55 INFO - Return code: 0 03:45:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:55 INFO - # TBPL SUCCESS # 03:45:55 INFO - Running post-action listener: _package_coverage_data 03:45:55 INFO - Running post-action listener: _resource_record_post_action 03:45:55 INFO - [mozharness: 2017-09-12 10:45:55.826709Z] Finished run-tests step (success) 03:45:55 INFO - Running post-run listener: _resource_record_post_run 03:45:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302055424; Read time: 16; Write time: 216204 03:45:55 INFO - TinderboxPrint: CPU usage
13.1% 03:45:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:45:55 INFO - TinderboxPrint: I/O write bytes / time
302,055,424 / 216,204 03:45:55 INFO - TinderboxPrint: CPU idle
8,237.7 (86.9%) 03:45:55 INFO - TinderboxPrint: CPU user
1,191.3 (12.6%) 03:45:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13082624; Read time: 0; Write time: 1196 03:45:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:45:55 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288972800; Read time: 16; Write time: 215008 03:45:56 INFO - Running post-run listener: _upload_blobber_files 03:45:56 INFO - Blob upload gear active. 03:45:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:56 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 03:45:56 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'] 03:45:56 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 03:45:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:57 INFO - (blobuploader) - INFO - Done attempting. 03:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:58 INFO - (blobuploader) - INFO - Done attempting. 03:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:59 INFO - (blobuploader) - INFO - Done attempting. 03:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:06 INFO - (blobuploader) - INFO - Done attempting. 03:46:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:06 INFO - Return code: 0 03:46:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03b10ee5965bd6c2fd0be7006da990a2787702c696e041e1e947d739f5d613b54721ac16a0ac07203f3955fcd17a308a08921cd8bacfdf3ae50a8c0e18ac08f9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad418bffc8e51d5f1cc65e9e52bec82d4f77849c53561ae7f213d6da91cb744850bca41a9da9dd1b7d9777f4b312a21f59fe0e264cde2375ee34c5fa23db5d2c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc50eb0cb3e4add7625c4eeda0e0e90b7b9ab7ebdca3ab24a1104345fb7699d4ebacddd43610f518d5008e94beaf52081ad851531ed3dc020f8064750916ed0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29e200a6680046ac19a289d898a578078e0ac6f15d6851aebbbe0def5e1df0fb7aed0e282ed262082cda9472caee15555d6b9a354f15dc2d6432c5d778bc70ea"} 03:46:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:06 INFO - Contents: 03:46:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03b10ee5965bd6c2fd0be7006da990a2787702c696e041e1e947d739f5d613b54721ac16a0ac07203f3955fcd17a308a08921cd8bacfdf3ae50a8c0e18ac08f9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad418bffc8e51d5f1cc65e9e52bec82d4f77849c53561ae7f213d6da91cb744850bca41a9da9dd1b7d9777f4b312a21f59fe0e264cde2375ee34c5fa23db5d2c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc50eb0cb3e4add7625c4eeda0e0e90b7b9ab7ebdca3ab24a1104345fb7699d4ebacddd43610f518d5008e94beaf52081ad851531ed3dc020f8064750916ed0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29e200a6680046ac19a289d898a578078e0ac6f15d6851aebbbe0def5e1df0fb7aed0e282ed262082cda9472caee15555d6b9a354f15dc2d6432c5d778bc70ea"} 03:46:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:06 INFO - Copying logs to upload dir... 03:46:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.950560 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-12 03:46:06.554311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:06.557813) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03b10ee5965bd6c2fd0be7006da990a2787702c696e041e1e947d739f5d613b54721ac16a0ac07203f3955fcd17a308a08921cd8bacfdf3ae50a8c0e18ac08f9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad418bffc8e51d5f1cc65e9e52bec82d4f77849c53561ae7f213d6da91cb744850bca41a9da9dd1b7d9777f4b312a21f59fe0e264cde2375ee34c5fa23db5d2c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc50eb0cb3e4add7625c4eeda0e0e90b7b9ab7ebdca3ab24a1104345fb7699d4ebacddd43610f518d5008e94beaf52081ad851531ed3dc020f8064750916ed0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29e200a6680046ac19a289d898a578078e0ac6f15d6851aebbbe0def5e1df0fb7aed0e282ed262082cda9472caee15555d6b9a354f15dc2d6432c5d778bc70ea"} build_url:https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/03b10ee5965bd6c2fd0be7006da990a2787702c696e041e1e947d739f5d613b54721ac16a0ac07203f3955fcd17a308a08921cd8bacfdf3ae50a8c0e18ac08f9", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad418bffc8e51d5f1cc65e9e52bec82d4f77849c53561ae7f213d6da91cb744850bca41a9da9dd1b7d9777f4b312a21f59fe0e264cde2375ee34c5fa23db5d2c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fc50eb0cb3e4add7625c4eeda0e0e90b7b9ab7ebdca3ab24a1104345fb7699d4ebacddd43610f518d5008e94beaf52081ad851531ed3dc020f8064750916ed0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29e200a6680046ac19a289d898a578078e0ac6f15d6851aebbbe0def5e1df0fb7aed0e282ed262082cda9472caee15555d6b9a354f15dc2d6432c5d778bc70ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:06.585942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:06.586322) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505207748.323292-922528836 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:06.669503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:06.669818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:06.670147) ========= ========= Total master_lag: 0.20 =========