builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-048 starttime: 1505214024.7 results: success (0) revision: b0e945eed81db8bf076daf64e381c514f70144f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.696120) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.696521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.696798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.752116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.752372) ========= 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=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 04:00:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-09-12 04:00:24 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.872062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.872395) ========= 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=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019187 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:24.930024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 04:00:24.930314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0e945eed81db8bf076daf64e381c514f70144f0 --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 b0e945eed81db8bf076daf64e381c514f70144f0 --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=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 04:00:24,897 truncating revision to first 12 chars 2017-09-12 04:00:24,897 Setting DEBUG logging. 2017-09-12 04:00:24,897 attempt 1/10 2017-09-12 04:00:24,897 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0e945eed81d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 04:00:25,495 unpacking tar archive at: mozilla-central-b0e945eed81d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937208 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 04:00:26.000429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:26.000718) ========= script_repo_revision: b0e945eed81db8bf076daf64e381c514f70144f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:26.001046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:26.001303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 04:00:26.027020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-12 04:00:26.027307) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:26 INFO - MultiFileLogger online at 20170912 04:00:26 in /builds/slave/test 04:00:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:00:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:26 INFO - {'append_to_log': False, 04:00:26 INFO - 'base_work_dir': '/builds/slave/test', 04:00:26 INFO - 'blob_upload_branch': 'Firefox', 04:00:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:26 INFO - 'branch': 'Firefox', 04:00:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:26 INFO - 'code_coverage': False, 04:00:26 INFO - 'config_files': ('talos/linux_config.py',), 04:00:26 INFO - 'default_actions': ('clobber', 04:00:26 INFO - 'read-buildbot-config', 04:00:26 INFO - 'download-and-extract', 04:00:26 INFO - 'populate-webroot', 04:00:26 INFO - 'create-virtualenv', 04:00:26 INFO - 'install', 04:00:26 INFO - 'setup-mitmproxy', 04:00:26 INFO - 'run-tests'), 04:00:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:26 INFO - 'disable_ccov_upload': False, 04:00:26 INFO - 'disable_stylo': False, 04:00:26 INFO - 'download_minidump_stackwalk': True, 04:00:26 INFO - 'download_symbols': 'ondemand', 04:00:26 INFO - 'enable_stylo': False, 04:00:26 INFO - 'enable_webrender': False, 04:00:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:00:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:26 INFO - 'gecko_profile': False, 04:00:26 INFO - 'gecko_profile_interval': 0, 04:00:26 INFO - 'installer_path': 'installer.exe', 04:00:26 INFO - 'log_level': 'info', 04:00:26 INFO - 'log_name': 'talos', 04:00:26 INFO - 'log_to_console': True, 04:00:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:26 INFO - 'opt_config_files': (), 04:00:26 INFO - 'pip_index': False, 04:00:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:00:26 INFO - 'system_bits': '32', 04:00:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:26 INFO - 'title': 'talos-linux64-ix-048', 04:00:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:26 INFO - 'use_talos_json': True, 04:00:26 INFO - 'verify': 'False', 04:00:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:26 INFO - 'work_dir': 'build'} 04:00:26 INFO - [mozharness: 2017-09-12 11:00:26.147431Z] Running clobber step. 04:00:26 INFO - Running pre-action listener: _resource_record_pre_action 04:00:26 INFO - Running main action method: clobber 04:00:26 INFO - rmtree: /builds/slave/test/build 04:00:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:27 INFO - Running post-action listener: _resource_record_post_action 04:00:27 INFO - [mozharness: 2017-09-12 11:00:27.662694Z] Finished clobber step (success) 04:00:27 INFO - [mozharness: 2017-09-12 11:00:27.662791Z] Running read-buildbot-config step. 04:00:27 INFO - Running pre-action listener: _resource_record_pre_action 04:00:27 INFO - Running main action method: read_buildbot_config 04:00:27 INFO - Using buildbot properties: 04:00:27 INFO - { 04:00:27 INFO - "project": "", 04:00:27 INFO - "product": "firefox", 04:00:27 INFO - "who": "archaeopteryx@coole-files.de", 04:00:27 INFO - "installer_path": "public/build/target.tar.bz2", 04:00:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:00:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:00:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:00:27 INFO - "stage_platform": "linux64-pgo", 04:00:27 INFO - "basedir": "/builds/slave/test", 04:00:27 INFO - "buildnumber": 4, 04:00:27 INFO - "platform": "ubuntu64_hw", 04:00:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:00:27 INFO - "slavebuilddir": "test", 04:00:27 INFO - "taskId": "Jly9doDvSle81tDjmf9Q2w", 04:00:27 INFO - "branch": "mozilla-central", 04:00:27 INFO - "script_repo_revision": "production", 04:00:27 INFO - "revision": "b0e945eed81db8bf076daf64e381c514f70144f0", 04:00:27 INFO - "slavename": "talos-linux64-ix-048", 04:00:27 INFO - "repo_path": "mozilla-central" 04:00:27 INFO - } 04:00:27 INFO - Finding installer, test and symbols from parent task. 04:00:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jly9doDvSle81tDjmf9Q2w'}, attempt #1 04:00:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jly9doDvSle81tDjmf9Q2w'}, attempt #1 04:00:28 INFO - Task dependencies: dQw1nXGeRJ-it9XJgZiT1A 04:00:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A'}, attempt #1 04:00:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 04:00:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.test_packages.json 04:00:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.crashreporter-symbols.zip 04:00:29 INFO - Running post-action listener: _resource_record_post_action 04:00:29 INFO - [mozharness: 2017-09-12 11:00:29.079930Z] Finished read-buildbot-config step (success) 04:00:29 INFO - [mozharness: 2017-09-12 11:00:29.080146Z] Running download-and-extract step. 04:00:29 INFO - Running pre-action listener: _resource_record_pre_action 04:00:29 INFO - Running main action method: download_and_extract 04:00:29 INFO - mkdir: /builds/slave/test/build/tests 04:00:29 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')]} 04:00:29 INFO - trying https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.test_packages.json 04:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:00:29 INFO - Downloaded 989 bytes. 04:00:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:00:29 INFO - Using the following test package requirements: 04:00:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:00:29 INFO - u'common': [u'target.common.tests.zip'], 04:00:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:00:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:00:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:00:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:00:29 INFO - u'mozbase': [u'target.common.tests.zip'], 04:00:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:00:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:00:29 INFO - u'web-platform': [u'target.common.tests.zip', 04:00:29 INFO - u'target.web-platform.tests.tar.gz'], 04:00:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:00:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:00:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.common.tests.zip 04:00:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:00:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.common.tests.zip into memory 04:00:30 INFO - Content-Length response header: 55712821 04:00:30 INFO - Bytes received: 55712821 04:00:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.talos.tests.zip 04:00:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:00:41 INFO - Fetch https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.talos.tests.zip into memory 04:00:42 INFO - Content-Length response header: 14499231 04:00:42 INFO - Bytes received: 14499231 04:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:42 INFO - trying https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 04:00:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:00:43 INFO - Downloaded 63671789 bytes. 04:00:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 04:00:43 INFO - mkdir: /builds/slave/test/properties 04:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:43 INFO - Contents: 04:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - Running post-action listener: find_tests_for_verification 04:00:43 INFO - Running post-action listener: set_extra_try_arguments 04:00:43 INFO - [mozharness: 2017-09-12 11:00:43.740629Z] Finished download-and-extract step (success) 04:00:43 INFO - [mozharness: 2017-09-12 11:00:43.740780Z] Running populate-webroot step. 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: populate_webroot 04:00:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['tresize', 04:00:43 INFO - 'tcanvasmark']}, 04:00:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['dromaeo_css', 04:00:43 INFO - 'kraken']}, 04:00:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'tests': ['damp', 'tps']}, 04:00:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['damp', 'tps']}, 04:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['dromaeo_dom']}, 04:00:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:00:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['basic_compositor_video', 04:00:43 INFO - 'glvideo']}, 04:00:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:00:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['ts_paint_webext', 04:00:43 INFO - 'tp5o_webext']}, 04:00:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_many_windows', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['a11yr', 04:00:43 INFO - 'ts_paint', 04:00:43 INFO - 'tpaint', 04:00:43 INFO - 'sessionrestore', 04:00:43 INFO - 'sessionrestore_many_windows', 04:00:43 INFO - 'sessionrestore_no_auto_restore', 04:00:43 INFO - 'tabpaint']}, 04:00:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:00:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:00:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['bloom_basic_singleton']}, 04:00:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['bloom_basic']}, 04:00:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:43 INFO - 'tsvgr_opacity', 04:00:43 INFO - 'tart', 04:00:43 INFO - 'tscrollx', 04:00:43 INFO - 'tsvg_static']}, 04:00:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['tsvgx', 04:00:43 INFO - 'tsvgr_opacity', 04:00:43 INFO - 'tart', 04:00:43 INFO - 'tscrollx', 04:00:43 INFO - 'tsvg_static']}, 04:00:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:00:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo'], 04:00:43 INFO - 'tests': ['tp5o']}, 04:00:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:43 INFO - 'talos_options': ['--mitmproxy', 04:00:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:43 INFO - '--firstNonBlankPaint'], 04:00:43 INFO - 'tests': ['tp6_google', 04:00:43 INFO - 'tp6_youtube', 04:00:43 INFO - 'tp6_amazon', 04:00:43 INFO - 'tp6_facebook']}, 04:00:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo', 04:00:43 INFO - '--mitmproxy', 04:00:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:43 INFO - '--firstNonBlankPaint'], 04:00:43 INFO - 'tests': ['tp6_google', 04:00:43 INFO - 'tp6_youtube', 04:00:43 INFO - 'tp6_amazon', 04:00:43 INFO - 'tp6_facebook']}, 04:00:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:43 INFO - 'talos_options': ['--stylo-threads=1', 04:00:43 INFO - '--mitmproxy', 04:00:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:43 INFO - '--firstNonBlankPaint'], 04:00:43 INFO - 'tests': ['tp6_google', 04:00:43 INFO - 'tp6_youtube', 04:00:43 INFO - 'tp6_amazon', 04:00:43 INFO - 'tp6_facebook']}, 04:00:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--xperf_path', 04:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:43 INFO - 'tests': ['tp5n']}, 04:00:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:00:43 INFO - 'talos_options': ['--disable-stylo', 04:00:43 INFO - '--xperf_path', 04:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:43 INFO - 'tests': ['tp5n']}}} 04:00:43 INFO - Running post-action listener: _resource_record_post_action 04:00:43 INFO - [mozharness: 2017-09-12 11:00:43.766456Z] Finished populate-webroot step (success) 04:00:43 INFO - [mozharness: 2017-09-12 11:00:43.766603Z] Running create-virtualenv step. 04:00:43 INFO - Running pre-action listener: _resource_record_pre_action 04:00:43 INFO - Running main action method: create_virtualenv 04:00:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:00:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:00:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:00:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:46 INFO - Installing pip...............done. 04:00:46 INFO - Return code: 0 04:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:00:46 INFO - Reading from file tmpfile_stdout 04:00:46 INFO - Output received: 04:00:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00:46 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')]} 04:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:46 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')]} 04:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:46 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 04:00:46 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 04:00:46 INFO - Using env: {'DISPLAY': ':0', 04:00:46 INFO - 'HOME': '/home/cltbld', 04:00:46 INFO - 'LANG': 'en_US.UTF-8', 04:00:46 INFO - 'LANGUAGE': 'en_US:en', 04:00:46 INFO - 'LOGNAME': 'cltbld', 04:00:46 INFO - 'MAIL': '/var/mail/cltbld', 04:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:46 INFO - 'MOZ_NO_REMOTE': '1', 04:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:46 INFO - 'NO_EM_RESTART': '1', 04:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:46 INFO - 'PWD': '/builds/slave/test', 04:00:46 INFO - 'SHELL': '/bin/bash', 04:00:46 INFO - 'SHLVL': '1', 04:00:46 INFO - 'TERM': 'linux', 04:00:46 INFO - 'TMOUT': '86400', 04:00:46 INFO - 'USER': 'cltbld', 04:00:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:46 INFO - '_': '/tools/buildbot/bin/python'} 04:00:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:00:47 INFO - Downloading/unpacking pip>=1.5 04:00:47 INFO - Running setup.py egg_info for package pip 04:00:47 INFO - warning: no files found matching 'pip/cacert.pem' 04:00:47 INFO - warning: no files found matching '*.html' under directory 'docs' 04:00:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:00:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:00:47 INFO - Installing collected packages: pip 04:00:47 INFO - Found existing installation: pip 1.1 04:00:47 INFO - Uninstalling pip: 04:00:47 INFO - Successfully uninstalled pip 04:00:47 INFO - Running setup.py install for pip 04:00:47 INFO - warning: no files found matching 'pip/cacert.pem' 04:00:47 INFO - warning: no files found matching '*.html' under directory 'docs' 04:00:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:00:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:00:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:00:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:00:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:00:47 INFO - Successfully installed pip 04:00:47 INFO - Cleaning up... 04:00:47 INFO - Return code: 0 04:00:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:47 INFO - Using env: {'DISPLAY': ':0', 04:00:47 INFO - 'HOME': '/home/cltbld', 04:00:47 INFO - 'LANG': 'en_US.UTF-8', 04:00:47 INFO - 'LANGUAGE': 'en_US:en', 04:00:47 INFO - 'LOGNAME': 'cltbld', 04:00:47 INFO - 'MAIL': '/var/mail/cltbld', 04:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:47 INFO - 'MOZ_NO_REMOTE': '1', 04:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:47 INFO - 'NO_EM_RESTART': '1', 04:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:47 INFO - 'PWD': '/builds/slave/test', 04:00:47 INFO - 'SHELL': '/bin/bash', 04:00:47 INFO - 'SHLVL': '1', 04:00:47 INFO - 'TERM': 'linux', 04:00:47 INFO - 'TMOUT': '86400', 04:00:47 INFO - 'USER': 'cltbld', 04:00:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:47 INFO - '_': '/tools/buildbot/bin/python'} 04:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:47 INFO - Downloading/unpacking psutil>=3.1.1 04:00: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 04:00: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 04:00: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 04:00: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 04:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:48 INFO - Installing collected packages: psutil 04:00:48 INFO - Running setup.py install for psutil 04:00:48 INFO - building 'psutil._psutil_linux' extension 04:00: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 04:00: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 04:00:49 INFO - building 'psutil._psutil_posix' extension 04:00: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 04:00: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 04:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:49 INFO - Successfully installed psutil 04:00:49 INFO - Cleaning up... 04:00:49 INFO - Return code: 0 04:00:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00:49 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')]} 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:49 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')]} 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00:49 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 04:00:49 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 04:00:49 INFO - Using env: {'DISPLAY': ':0', 04:00:49 INFO - 'HOME': '/home/cltbld', 04:00:49 INFO - 'LANG': 'en_US.UTF-8', 04:00:49 INFO - 'LANGUAGE': 'en_US:en', 04:00:49 INFO - 'LOGNAME': 'cltbld', 04:00:49 INFO - 'MAIL': '/var/mail/cltbld', 04:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:49 INFO - 'MOZ_NO_REMOTE': '1', 04:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:49 INFO - 'NO_EM_RESTART': '1', 04:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:49 INFO - 'PWD': '/builds/slave/test', 04:00:49 INFO - 'SHELL': '/bin/bash', 04:00:49 INFO - 'SHLVL': '1', 04:00:49 INFO - 'TERM': 'linux', 04:00:49 INFO - 'TMOUT': '86400', 04:00:49 INFO - 'USER': 'cltbld', 04:00:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:49 INFO - '_': '/tools/buildbot/bin/python'} 04:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:50 INFO - Installing collected packages: mozsystemmonitor 04:00:50 INFO - Running setup.py install for mozsystemmonitor 04:00:51 INFO - Successfully installed mozsystemmonitor 04:00:51 INFO - Cleaning up... 04:00:52 INFO - Return code: 0 04:00:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:52 INFO - Using env: {'DISPLAY': ':0', 04:00:52 INFO - 'HOME': '/home/cltbld', 04:00:52 INFO - 'LANG': 'en_US.UTF-8', 04:00:52 INFO - 'LANGUAGE': 'en_US:en', 04:00:52 INFO - 'LOGNAME': 'cltbld', 04:00:52 INFO - 'MAIL': '/var/mail/cltbld', 04:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:52 INFO - 'MOZ_NO_REMOTE': '1', 04:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:52 INFO - 'NO_EM_RESTART': '1', 04:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:52 INFO - 'PWD': '/builds/slave/test', 04:00:52 INFO - 'SHELL': '/bin/bash', 04:00:52 INFO - 'SHLVL': '1', 04:00:52 INFO - 'TERM': 'linux', 04:00:52 INFO - 'TMOUT': '86400', 04:00:52 INFO - 'USER': 'cltbld', 04:00:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:52 INFO - '_': '/tools/buildbot/bin/python'} 04:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:52 INFO - Downloading/unpacking jsonschema==2.5.1 04:00: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 04:00: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 04:00: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 04:00: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 04:00:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:54 INFO - warning: no files found matching '*.txt' 04:00:54 INFO - no previously-included directories found matching 'build' 04:00:54 INFO - no previously-included directories found matching 'dist' 04:00:54 INFO - no previously-included directories found matching '.git*' 04:00:54 INFO - Installing collected packages: jsonschema, functools32 04:00:54 INFO - Running setup.py install for functools32 04:00:54 INFO - warning: no files found matching '*.txt' 04:00:54 INFO - no previously-included directories found matching 'build' 04:00:54 INFO - no previously-included directories found matching 'dist' 04:00:54 INFO - no previously-included directories found matching '.git*' 04:00:54 INFO - Successfully installed jsonschema functools32 04:00:54 INFO - Cleaning up... 04:00:54 INFO - Return code: 0 04:00:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:54 INFO - Using env: {'DISPLAY': ':0', 04:00:54 INFO - 'HOME': '/home/cltbld', 04:00:54 INFO - 'LANG': 'en_US.UTF-8', 04:00:54 INFO - 'LANGUAGE': 'en_US:en', 04:00:54 INFO - 'LOGNAME': 'cltbld', 04:00:54 INFO - 'MAIL': '/var/mail/cltbld', 04:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:54 INFO - 'MOZ_NO_REMOTE': '1', 04:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:54 INFO - 'NO_EM_RESTART': '1', 04:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:54 INFO - 'PWD': '/builds/slave/test', 04:00:54 INFO - 'SHELL': '/bin/bash', 04:00:54 INFO - 'SHLVL': '1', 04:00:54 INFO - 'TERM': 'linux', 04:00:54 INFO - 'TMOUT': '86400', 04:00:54 INFO - 'USER': 'cltbld', 04:00:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:54 INFO - '_': '/tools/buildbot/bin/python'} 04:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:00:54 INFO - Cleaning up... 04:00:54 INFO - Return code: 0 04:00:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:54 INFO - Using env: {'DISPLAY': ':0', 04:00:54 INFO - 'HOME': '/home/cltbld', 04:00:54 INFO - 'LANG': 'en_US.UTF-8', 04:00:54 INFO - 'LANGUAGE': 'en_US:en', 04:00:54 INFO - 'LOGNAME': 'cltbld', 04:00:54 INFO - 'MAIL': '/var/mail/cltbld', 04:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:54 INFO - 'MOZ_NO_REMOTE': '1', 04:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:54 INFO - 'NO_EM_RESTART': '1', 04:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:54 INFO - 'PWD': '/builds/slave/test', 04:00:54 INFO - 'SHELL': '/bin/bash', 04:00:54 INFO - 'SHLVL': '1', 04:00:54 INFO - 'TERM': 'linux', 04:00:54 INFO - 'TMOUT': '86400', 04:00:54 INFO - 'USER': 'cltbld', 04:00:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:54 INFO - '_': '/tools/buildbot/bin/python'} 04:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:00: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 04:00: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 04:00: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 04:00: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 04:00:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:56 INFO - Downloading docopt-0.6.1.tar.gz 04:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:56 INFO - Running setup.py install for blobuploader 04:00:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:56 INFO - Running setup.py install for requests 04:00:56 INFO - Running setup.py install for docopt 04:00:57 INFO - Successfully installed blobuploader requests docopt 04:00:57 INFO - Cleaning up... 04:00:57 INFO - Return code: 0 04:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:00: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 04:00: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 04:00:57 INFO - Using env: {'DISPLAY': ':0', 04:00:57 INFO - 'HOME': '/home/cltbld', 04:00:57 INFO - 'LANG': 'en_US.UTF-8', 04:00:57 INFO - 'LANGUAGE': 'en_US:en', 04:00:57 INFO - 'LOGNAME': 'cltbld', 04:00:57 INFO - 'MAIL': '/var/mail/cltbld', 04:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:57 INFO - 'MOZ_NO_REMOTE': '1', 04:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:57 INFO - 'NO_EM_RESTART': '1', 04:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:57 INFO - 'PWD': '/builds/slave/test', 04:00:57 INFO - 'SHELL': '/bin/bash', 04:00:57 INFO - 'SHLVL': '1', 04:00:57 INFO - 'TERM': 'linux', 04:00:57 INFO - 'TMOUT': '86400', 04:00:57 INFO - 'USER': 'cltbld', 04:00:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:57 INFO - '_': '/tools/buildbot/bin/python'} 04:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:57 INFO - Running setup.py (path:/tmp/pip-LAWjts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:57 INFO - Running setup.py (path:/tmp/pip-7XQFmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:57 INFO - Running setup.py (path:/tmp/pip-mIpZRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:57 INFO - Running setup.py (path:/tmp/pip-qBC90H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:57 INFO - Running setup.py (path:/tmp/pip-PG3ppS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:57 INFO - Running setup.py (path:/tmp/pip-kJjCf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:57 INFO - Running setup.py (path:/tmp/pip-YsYuse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:57 INFO - Running setup.py (path:/tmp/pip-E1X3gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:57 INFO - Running setup.py (path:/tmp/pip-vnilfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:57 INFO - Running setup.py (path:/tmp/pip-H_L_l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:58 INFO - Running setup.py (path:/tmp/pip-ogFDCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:58 INFO - Running setup.py (path:/tmp/pip-H2AI6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:58 INFO - Running setup.py (path:/tmp/pip-zQXcAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:58 INFO - Running setup.py (path:/tmp/pip-ePuFXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:58 INFO - Running setup.py (path:/tmp/pip-Oz7oiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:58 INFO - Running setup.py (path:/tmp/pip-bUBz37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:58 INFO - Running setup.py (path:/tmp/pip-Pp9wtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:58 INFO - Running setup.py install for manifestparser 04:00:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:58 INFO - Running setup.py install for mozcrash 04:00:58 INFO - Running setup.py install for mozdebug 04:00:58 INFO - Running setup.py install for mozdevice 04:00:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:58 INFO - Running setup.py install for mozfile 04:00:59 INFO - Running setup.py install for mozhttpd 04:00:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for mozinfo 04:00:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for mozInstall 04:00:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for mozleak 04:00:59 INFO - Running setup.py install for mozlog 04:00:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for moznetwork 04:00:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for mozprocess 04:00:59 INFO - Running setup.py install for mozprofile 04:00:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:59 INFO - Running setup.py install for mozrunner 04:01:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:00 INFO - Running setup.py install for mozscreenshot 04:01:00 INFO - Running setup.py install for moztest 04:01:00 INFO - Running setup.py install for mozversion 04:01:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:00 INFO - Cleaning up... 04:01:00 INFO - Return code: 0 04:01:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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 04:01: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 04:01:00 INFO - Using env: {'DISPLAY': ':0', 04:01:00 INFO - 'HOME': '/home/cltbld', 04:01:00 INFO - 'LANG': 'en_US.UTF-8', 04:01:00 INFO - 'LANGUAGE': 'en_US:en', 04:01:00 INFO - 'LOGNAME': 'cltbld', 04:01:00 INFO - 'MAIL': '/var/mail/cltbld', 04:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:00 INFO - 'MOZ_NO_REMOTE': '1', 04:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:00 INFO - 'NO_EM_RESTART': '1', 04:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:00 INFO - 'PWD': '/builds/slave/test', 04:01:00 INFO - 'SHELL': '/bin/bash', 04:01:00 INFO - 'SHLVL': '1', 04:01:00 INFO - 'TERM': 'linux', 04:01:00 INFO - 'TMOUT': '86400', 04:01:00 INFO - 'USER': 'cltbld', 04:01:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:00 INFO - '_': '/tools/buildbot/bin/python'} 04:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:00 INFO - Running setup.py (path:/tmp/pip-uzWN77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:00 INFO - Running setup.py (path:/tmp/pip-ja3Uac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:00 INFO - Running setup.py (path:/tmp/pip-ukq7mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:00 INFO - Running setup.py (path:/tmp/pip-76SYGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:00 INFO - Running setup.py (path:/tmp/pip-ZGvtfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:00 INFO - Running setup.py (path:/tmp/pip-idIZeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01: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)) 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:00 INFO - Running setup.py (path:/tmp/pip-x4aY8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:01 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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:01 INFO - Running setup.py (path:/tmp/pip-LG0QJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:01 INFO - Running setup.py (path:/tmp/pip-5Lf3KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:01 INFO - Running setup.py (path:/tmp/pip-hv6Tdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:01 INFO - Running setup.py (path:/tmp/pip-Xd4nKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:01 INFO - Running setup.py (path:/tmp/pip-KTqwem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:01 INFO - Running setup.py (path:/tmp/pip-szGGJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:01 INFO - Running setup.py (path:/tmp/pip-1DyJM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:01 INFO - Running setup.py (path:/tmp/pip-PAuJGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:01 INFO - Running setup.py (path:/tmp/pip-yV7nec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01: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)) 04:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:01 INFO - Running setup.py (path:/tmp/pip-f1N_It-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01: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 04:01: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 04:01: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 04:01: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 04:01:02 INFO - Downloading blessings-1.6.tar.gz 04:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:02 INFO - Installing collected packages: blessings 04:01:02 INFO - Running setup.py install for blessings 04:01:03 INFO - Successfully installed blessings 04:01:03 INFO - Cleaning up... 04:01:03 INFO - Return code: 0 04:01:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:03 INFO - Reading from file tmpfile_stdout 04:01:03 INFO - Current package versions: 04:01:03 INFO - argparse == 1.2.1 04:01:03 INFO - blessings == 1.6 04:01:03 INFO - blobuploader == 1.2.4 04:01:03 INFO - docopt == 0.6.1 04:01:03 INFO - functools32 == 3.2.3-2 04:01:03 INFO - jsonschema == 2.5.1 04:01:03 INFO - manifestparser == 1.1 04:01:03 INFO - mozInstall == 1.13 04:01:03 INFO - mozcrash == 1.0 04:01:03 INFO - mozdebug == 0.1 04:01:03 INFO - mozdevice == 0.51 04:01:03 INFO - mozfile == 1.2 04:01:03 INFO - mozhttpd == 0.7 04:01:03 INFO - mozinfo == 0.10 04:01:03 INFO - mozleak == 0.1 04:01:03 INFO - mozlog == 3.5 04:01:03 INFO - moznetwork == 0.27 04:01:03 INFO - mozprocess == 0.25 04:01:03 INFO - mozprofile == 0.28 04:01:03 INFO - mozrunner == 6.13 04:01:03 INFO - mozscreenshot == 0.1 04:01:03 INFO - mozsystemmonitor == 0.3 04:01:03 INFO - moztest == 0.8 04:01:03 INFO - mozversion == 1.4 04:01:03 INFO - psutil == 3.1.1 04:01:03 INFO - requests == 1.2.3 04:01:03 INFO - wsgiref == 0.1.2 04:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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 04:01: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 04:01:03 INFO - Using env: {'DISPLAY': ':0', 04:01:03 INFO - 'HOME': '/home/cltbld', 04:01:03 INFO - 'LANG': 'en_US.UTF-8', 04:01:03 INFO - 'LANGUAGE': 'en_US:en', 04:01:03 INFO - 'LOGNAME': 'cltbld', 04:01:03 INFO - 'MAIL': '/var/mail/cltbld', 04:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:03 INFO - 'MOZ_NO_REMOTE': '1', 04:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:03 INFO - 'NO_EM_RESTART': '1', 04:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:03 INFO - 'PWD': '/builds/slave/test', 04:01:03 INFO - 'SHELL': '/bin/bash', 04:01:03 INFO - 'SHLVL': '1', 04:01:03 INFO - 'TERM': 'linux', 04:01:03 INFO - 'TMOUT': '86400', 04:01:03 INFO - 'USER': 'cltbld', 04:01:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:03 INFO - '_': '/tools/buildbot/bin/python'} 04:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01: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)) 04:01:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:01: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 04:01: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 04:01: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 04:01: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 04:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:01: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)) 04:01: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)) 04:01:04 INFO - Installing collected packages: simplejson 04:01:04 INFO - Running setup.py install for simplejson 04:01:04 INFO - building 'simplejson._speedups' extension 04:01: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 04:01: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 04:01:05 INFO - Successfully installed simplejson 04:01:05 INFO - Cleaning up... 04:01:05 INFO - Return code: 0 04:01:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01: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')]} 04:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01: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 0x18b51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:01: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 04:01: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 04:01:05 INFO - Using env: {'DISPLAY': ':0', 04:01:05 INFO - 'HOME': '/home/cltbld', 04:01:05 INFO - 'LANG': 'en_US.UTF-8', 04:01:05 INFO - 'LANGUAGE': 'en_US:en', 04:01:05 INFO - 'LOGNAME': 'cltbld', 04:01:05 INFO - 'MAIL': '/var/mail/cltbld', 04:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:05 INFO - 'MOZ_NO_REMOTE': '1', 04:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:05 INFO - 'NO_EM_RESTART': '1', 04:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:05 INFO - 'PWD': '/builds/slave/test', 04:01:05 INFO - 'SHELL': '/bin/bash', 04:01:05 INFO - 'SHLVL': '1', 04:01:05 INFO - 'TERM': 'linux', 04:01:05 INFO - 'TMOUT': '86400', 04:01:05 INFO - 'USER': 'cltbld', 04:01:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:05 INFO - '_': '/tools/buildbot/bin/python'} 04:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:01:05 INFO - Cleaning up... 04:01:06 INFO - Return code: 0 04:01:06 INFO - Running post-action listener: _resource_record_post_action 04:01:06 INFO - Running post-action listener: _start_resource_monitoring 04:01:06 INFO - Starting resource monitoring. 04:01:06 INFO - [mozharness: 2017-09-12 11:01:06.037678Z] Finished create-virtualenv step (success) 04:01:06 INFO - [mozharness: 2017-09-12 11:01:06.038194Z] Running install step. 04:01:06 INFO - Running pre-action listener: _resource_record_pre_action 04:01:06 INFO - Running main action method: install 04:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:06 INFO - Reading from file tmpfile_stdout 04:01:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:06 INFO - Reading from file tmpfile_stdout 04:01:06 INFO - Output received: 04:01:06 INFO - Usage: mozinstall [options] installer 04:01:06 INFO - Options: 04:01:06 INFO - -h, --help show this help message and exit 04:01:06 INFO - -d DEST, --destination=DEST 04:01:06 INFO - Directory to install application into. [default: 04:01:06 INFO - "/builds/slave/test"] 04:01:06 INFO - --app=APP Application being installed. [default: firefox] 04:01:06 INFO - mkdir: /builds/slave/test/build/application 04:01: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'] 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:01:23 INFO - Reading from file tmpfile_stdout 04:01:23 INFO - Output received: 04:01:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:23 INFO - Running post-action listener: _resource_record_post_action 04:01:23 INFO - [mozharness: 2017-09-12 11:01:23.655843Z] Finished install step (success) 04:01:23 INFO - [mozharness: 2017-09-12 11:01:23.655971Z] Running setup-mitmproxy step. 04:01:23 INFO - Running pre-action listener: _resource_record_pre_action 04:01:23 INFO - Running main action method: setup_mitmproxy 04:01:23 INFO - Skipping: mitmproxy is not required 04:01:23 INFO - Running post-action listener: _resource_record_post_action 04:01:23 INFO - [mozharness: 2017-09-12 11:01:23.656612Z] Finished setup-mitmproxy step (success) 04:01:23 INFO - [mozharness: 2017-09-12 11:01:23.656833Z] Running run-tests step. 04:01:23 INFO - Running pre-action listener: _resource_record_pre_action 04:01:23 INFO - Running pre-action listener: _set_gcov_prefix 04:01:23 INFO - Running main action method: run_tests 04:01:23 WARNING - Try message not found. 04:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:23 INFO - Python 2.7.3 04:01:23 INFO - Return code: 0 04:01:23 INFO - grabbing minidump binary from tooltool 04:01:23 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')]} 04:01:23 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 0x1c25090>, '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 0x1c25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c1ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:23 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 04:01:23 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 04:01:23 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 04:01:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:23 INFO - Return code: 0 04:01:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:23 INFO - ENV: RUST_BACKTRACE is now full 04:01:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:01:23 INFO - Using env: {'DISPLAY': ':0', 04:01:23 INFO - 'HOME': '/home/cltbld', 04:01:23 INFO - 'LANG': 'en_US.UTF-8', 04:01:23 INFO - 'LANGUAGE': 'en_US:en', 04:01:23 INFO - 'LOGNAME': 'cltbld', 04:01:23 INFO - 'MAIL': '/var/mail/cltbld', 04:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:23 INFO - 'MOZ_NO_REMOTE': '1', 04:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:23 INFO - 'NO_EM_RESTART': '1', 04:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:23 INFO - 'PWD': '/builds/slave/test', 04:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:23 INFO - 'RUST_BACKTRACE': 'full', 04:01:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:23 INFO - 'SHELL': '/bin/bash', 04:01:23 INFO - 'SHLVL': '1', 04:01:23 INFO - 'TERM': 'linux', 04:01:23 INFO - 'TMOUT': '86400', 04:01:23 INFO - 'USER': 'cltbld', 04:01:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:23 INFO - '_': '/tools/buildbot/bin/python'} 04:01:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:01:24 INFO - mozversion application_buildid: 20170912093540 04:01:24 INFO - mozversion application_changeset: b0e945eed81db8bf076daf64e381c514f70144f0 04:01:24 INFO - mozversion application_display_name: Nightly 04:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:24 INFO - mozversion application_name: Firefox 04:01:24 INFO - mozversion application_remotingname: firefox 04:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:01:24 INFO - mozversion application_vendor: Mozilla 04:01:24 INFO - mozversion application_version: 57.0a1 04:01:24 INFO - mozversion platform_buildid: 20170912093540 04:01:24 INFO - mozversion platform_changeset: b0e945eed81db8bf076daf64e381c514f70144f0 04:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:01:24 INFO - mozversion platform_version: 57.0a1 04:01:24 INFO - using testdate: 1505214084 04:01:24 INFO - actual date: 1505214084 04:01:24 INFO - starting webserver on 'localhost:55611' 04:01:24 INFO - SUITE-START | Running 2 tests 04:01:24 INFO - TEST-START | dromaeo_css 04:01:24 INFO - Initialising browser for dromaeo_css test... 04:01:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55611/getInfo.html -profile /tmp/tmpJzNqgx/profile 04:01:24 INFO - TEST-INFO | started process 11244 (/builds/slave/test/build/application/firefox/firefox http://localhost:55611/getInfo.html) 04:01:30 INFO - TEST-INFO | 11244: exit 0 04:01:30 INFO - Browser initialized. 04:01:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:30 INFO - Using env: {'DISPLAY': ':0', 04:01:30 INFO - 'HOME': '/home/cltbld', 04:01:30 INFO - 'JSGC_DISABLE_POISONING': '1', 04:01:30 INFO - 'LANG': 'en_US.UTF-8', 04:01:30 INFO - 'LANGUAGE': 'en_US:en', 04:01:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:01:30 INFO - 'LOGNAME': 'cltbld', 04:01:30 INFO - 'MAIL': '/var/mail/cltbld', 04:01:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:30 INFO - 'MOZ_CRASHREPORTER': '1', 04:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:01:30 INFO - 'MOZ_NO_REMOTE': '1', 04:01:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:30 INFO - 'NO_EM_RESTART': '1', 04:01:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:30 INFO - 'PWD': '/builds/slave/test', 04:01:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:30 INFO - 'RUST_BACKTRACE': 'full', 04:01:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:01:30 INFO - 'SHELL': '/bin/bash', 04:01:30 INFO - 'SHLVL': '1', 04:01:30 INFO - 'STYLO_FORCE_DISABLED': '1', 04:01:30 INFO - 'TERM': 'linux', 04:01:30 INFO - 'TMOUT': '86400', 04:01:30 INFO - 'USER': 'cltbld', 04:01:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:30 INFO - '_': '/tools/buildbot/bin/python'} 04:01:30 INFO - TEST-INFO | started process 11446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzNqgx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:31 INFO - PID 11446 | 04:01:31 INFO - PID 11446 | (/builds/slave/test/build/application/firefox/firefox:11497): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:01:31 INFO - PID 11446 | 04:01:41 INFO - PID 11446 | RSS: Main: 158318592 04:01:41 INFO - PID 11446 | 04:04:38 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55611/tests/dromaeo/cssquery-ext.html) 04:04:40 INFO - PID 11446 | RSS: Main: 163291136 04:04:40 INFO - PID 11446 | 04:07:41 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-ext.html (next: http://localhost:55611/tests/dromaeo/cssquery-jquery.html) 04:07:42 INFO - PID 11446 | RSS: Main: 161742848 04:07:42 INFO - PID 11446 | 04:10:43 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55611/tests/dromaeo/cssquery-mootools.html) 04:10:44 INFO - PID 11446 | RSS: Main: 164057088 04:10:44 INFO - PID 11446 | 04:13:46 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55611/tests/dromaeo/cssquery-prototype.html) 04:13:46 INFO - PID 11446 | RSS: Main: 162250752 04:13:46 INFO - PID 11446 | 04:16:49 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55611/tests/dromaeo/cssquery-yui.html) 04:16:50 INFO - PID 11446 | RSS: Main: 164020224 04:16:50 INFO - PID 11446 | 04:19:51 INFO - PID 11446 | Cycle 1(1): loaded http://localhost:55611/tests/dromaeo/cssquery-yui.html (next: http://localhost:55611/tests/dromaeo/cssquery-dojo.html) 04:19:52 INFO - PID 11446 | RSS: Main: 165306368 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | __start_tp_report 04:19:52 INFO - PID 11446 | _x_x_mozilla_page_load 04:19:52 INFO - PID 11446 | _x_x_mozilla_page_load_details 04:19:52 INFO - PID 11446 | |i|pagename|runs| 04:19:52 INFO - PID 11446 | |0;dojo.html;3809.657130858222;3869.2454971280577;3904.648581627654;3935.8032098395083;3947.092168801176;6203.689815509223;6333.398327158919;6347.1431356766825;6363.840903977403;6364.45902098321;6199.969000155004;6286.528510361718;6290.874182516359;6303.117563541108;6368.745250189999;5534.723263836802;5569.8607534811545;5635.8591035224035;5658.405867383906;5706.258186435757;5259.077888805902;5501.477359650827;5598.664080155204;5664.490195882369;5671.914921276184;5586.692731899744;5621.4940655341015;5653.971730141323;5657.264555607745;5664;5578.609497335188;5594.412586678381;5658.74535645897;5692.658440493584;5704.172894930211;5518.365387980353;5595.104783234663;5608.4391560844;5652.010898092817;5657.462541058593;6156.384361563808;6280.089387038899;6280.528960327993;6307.716152773136;6333.398327158912;6809.285025072395;6845.247022827485;6889.311068893121;6891.345322194384;6916.412104971084;6831.180258368978;6867;6871.4502839772695;6946.895796563055;6947.826304342381;6425.967870160666;6435.74257029723;6446.742130314782;6454.22549294083;6466.838329041811;6983.406410455066;6986;6993.580385176906;7019.0875186226485;7078.964605176941;6657.7669781557415;6689.130413046273;6705.832354191184;6733.8989915151315;6798.76204332846;6782.491313151533;6825.9317406826285;6829.351211634887;6843.452523798084;6843.589384636938;6709.329067093349;6732;6798.388145066968;6815.318468153145;6851.588904665637;6683.565568238049;6732.360425759545;6787.524873258923;6796.660166991631;6854.383105520527;4969.950300497021;4976.303317535548;5010.749462526859;5019.723915184627;5036.899262014739;4485.394471746337;4488.865334039984;4592.540745925381;4636.976815115971;4646.09401166776;6234.407731265523;6270.811875643738;6308.243010838729;6325.652089135142;6339.524535659844;6617.437517810944;6638.435732962752;6678.966605166943;6734.225564060098;6815.318468153145;6321.715522801485;6360.9822428411235;6374.075759014917;6388.169537960035;6394.0408938659575;5480.26016487777;5507.642003269774;5541.972290138524;5580.665160090408;5584.078627026495;6934.826629334307;7039.507234493536;7057.576545407292;7062.858742825115;7151.141862976476;6807.3873351398615;6808.5914845109455;6823.112995310578;6872.725090996304;6885.862282754217;7063.434925205868;7153.82115447118;7155.821104472429;7179.030830837979;7184.353408193288;6637.867242655023;6745.3591908768585;6752.932470675427;6842.042114104129;6854.040434339297;6706.262311145868;6784.525083244323;6784.660766961533;6789.93210067893;6793.796186114425;6486.091947127312;6506.934930650822;6507.28419873823;6524.510661700297;6609.966950165219;6410.391012853772;6517.543771936109;6533.281339052605;6623.735050598115;6624.867502649824;6454.031895215755;6543.901841472287;6552.737890484327;6590.176227971504;6594.043863639841;6563.146790917342;6604.471642268511;6668.166479190101;6672.132622759011;6713.362230588086;6379.7129129190225;6411.6153030818305;6416.839579010375;6458.483321334376;6519.837004074936 04:19:52 INFO - PID 11446 | |1;ext.html;955.4458414119811;979.0258692600863;980.14727187347;982.5971351745782;983.4381436358291;44168.77915610422;44647.55352446475;44691;44752.3287150693;44774.77612611932;43135.137297254034;43272.35091473631;43322.35016474756;43367.13265734683;43396.783016084955;7331.230220826817;7435.591042492661;7438.181800001996;7440.851182976337;7443;7387.889181662279;7423.183449820515;7454.068241469817;7454.925450745504;7467.365273951721;7936.682532698714;8082.39382046346;8094.231048050426;8097.35221182304;8110.270075693186;7992.640331185082;8011.67953281868;8021.278084972322;8029.959850200741;8034.357251419901;7646.541207527511;7766;7772.727954521564;7775.572343521104;7885.369170466349;40756.59243407587;41139.38290925638;41176.588234117575;41192.58807411917;41195;3742.9812850935573;3785.8107094645434;3788.5074940257864;3789.0148561373967;3793.6206379361843;33937.83031084829;33942.83028584866;33980.660193398;33997.660023399694;34017;5425.83722488326;5462.754176062087;5497.780088796443;5506.944930550723;5527.861803454945;214626;216913;217640;217709;218791;47376.7631161842;54670.453295467334;55027;55093.72453137708;55138.72430637821;56925.14612280819;57130;57132.714336428886;57199;57346;17148.914255428645;17297;17301.7404738929;17303.91348043277;17311;14251.78622320666;14297.571072867831;14305.356258968372;14309.57071287863;14315.498957536436;14983.250837458083;15053.172075535951;15055.096694198382;15154.469593564392;15165.696686066216;5664.801731939362;5780.971095144498;5788.179801331185;5893.5874488785375;5964.373740757244;1084.4144162152506;1090.2804149261449;1097.939613321259;1101.8347247912877;1105.7401510644993;25928.74071259301;26408;26539.46921061568;26589;26758.464830703666;1192.6171320397505;1207.704112492445;1212.2786941769632;1217.549506682533;1218.585680868509;13833.446662133603;13863.445462181602;13915.512957046454;14150.504732334319;14229.28853557318;301110;305019;305096;305200;305604;61200.08199877005;61581.69209154015;67447;67664.32335676679;67859.66070169618;1495.28973737476;1517.9696406071816;1518.1270769307691;1519.3390874969423;1532.5785409012387;32096.518552222202;32178;32355.676443236207;32445.35109297848;33068.503972440914;43781.56218437902;43983.340249895635;44021.77989110034;44055.33916991312;44156.025957663966;263043;263408;263491;263555;264293;38760.41859372168;41415.7929210352;41736;41933.58066419297;41997.37003944882;51403.2289515665;51544.74227628838;52326.73836630792;52385.214221787464;52396;37791.62208377881;37886.62113378941;38191.427128592535;38295.617043830316;38528.80735596304;36978.815105924295;37137.44293835541;37583.62416375911;37640;37908.81045594755;43065.13869722651;44150.55849441465;44470.11059778851;44522.77738611286;44635.77682111569;36005.27989440144;36036.81981590075;36241.818790905876;36259.27481450409;36671.449928250564;27216.863915680296;27575;27833.72166278311;27871.72128278691;27898.581521277603 04:19:52 INFO - PID 11446 | |2;jquery.html;582.7552427980248;589.1222079102138;591.160552016137;592.3987153039666;607.1560530862101;21746.782532174675;22467.438314042138;22597.209097681585;22653.99999999996;22675.773242267594;24481.877590612068;24969.37576560587;25412.745872541316;25578.84895179717;25604.23187304379;6567.605943643384;6734.562253453534;6739.393454589086;6743.662816859162;6748.358905903931;6568.376004279586;6662.034005069262;6729.25978142404;6744.089547911019;6759.1213142291435;6763.391294783469;6768.593884366929;6774.085498457719;6774.356436138559;6780.627065511395;6782;6795.796126116175;6802.217744959344;6809.727610895583;6821.079154314154;6082.452579267843;6311.968440157816;6326.778562750282;6335.461485773715;6344.270408902989;28974;29399.412011759858;29411.11766647004;29467.11598652044;29502.852485737432;2291.9541609167723;2327.93016209514;2328.871912044837;2330.906763729449;2332.0205513684296;19641.116149773152;20149.79850201494;20418.795812041837;20617.5876482471;20662.793372066237;2417.226487523993;2464.1621848571394;2464.371585245769;2490.887910044052;2536.9238922832346;141010.29494852564;147137;154499;161413.19293403576;161467;15093.24533773307;15291.388344466319;15475;15489.14809685478;15932.920335398248;24888.253352399457;24917.87541062283;24932.376690582518;24958;24993.500129997297;10118.645847395306;10153.94923025395;10181.949090254502;10228.07947284748;10304.793904122025;9216.723498295061;9227.53862306882;9274.30442716799;9295.256379489625;9413;9337.253019758538;9516.762080948032;9584.712458626253;9592.472414017297;9979.750506237402;2695.878685459159;2702.4730177615174;2720.3743139078124;2874.152125123094;2955.5123404638425;1029.7271223125877;1055.6569115037644;1057.3285963413289;1059.586761163147;1061.766411389493;19962;20549.48626284325;20796.376108716762;21319.8934005329;21352.679709804364;1121.0303087829132;1127.1264769803468;1128.5598616539555;1129.2377645089532;1134.4271143072694;11338.206325557132;11463.140264480196;11481.483333250024;11586.246893951866;11707.590234341757;615283;623789;630059;631140;635494;128260;130008.3499582496;130303;130659;132186;1197.8981786548068;1228.5515786737776;1236.8330275412884;1254.7866862633375;1258.8300579421843;17942.5514362142;18500.16749246314;18518.2592696296;18693.81306186975;18733.90633046826;64285.35714642794;64536;65423.34576654363;65635.7027504035;66478.33521664915;79255.60372198332;79625.2037479641;79823.60088199521;80164.59917700374;80971.19028809636;14703.264836758333;14985.40058397652;15014.774778378114;15087.622809429851;15095.849041509884;23255.18606848752;23455.41361465977;23523;23668.171613994116;23800.047998080576;19197.90401047986;19251.903740481208;19420.902895485997;19519.316823911096;19533;16563.585910352336;17149.142542873054;17259.13704314754;17605.29578816884;17782.199801009243;18773.624527509648;19259.711104333164;19905.502362440475;20015.199392024155;20301.79698203058;14570.125792452487;14756.040857344238;14804.925975370053;14892.255387230378;14896.40414383456;19229;19267.903660481606;19275.51811204731;19324.227030918606;19389.903050484656 04:19:52 INFO - PID 11446 | |3;mootools.html;1405.4588983241451;1465.9549927850649;1473.6389584551787;1478.874295684867;1480.4448331875553;16106;16732.330706771743;16748.83251167488;16755;16781.160941952898;16344.427945021896;16388.75416868748;16437.753433698475;16453.753193702105;16457.423990160347;2767.5571908494594;2869.4834929712642;2888.696686847882;2891.0459548348995;2891.971080289202;2660.3881107345323;2748.367875388662;2752.477029364424;2752.9862350688218;2753.3529620539257;2813.4091840713477;2903.840288784116;2905.7239562241552;2906.258903979482;2906.8110572812807;2695.7034726180104;2696.1776658119265;2712.6066720325443;2718.673759148895;2718.687350954636;2764.7373499517716;2785.4429114177246;2868.727470890262;2874.3101655602713;2877.654681438241;16548.338066477325;16698.916505417394;16710.331586736516;16736.66526669472;16739.66520669592;8358;8607.784805379853;8609.440386374865;8614.310855131636;8640.697575584825;5466.234727138204;5575.8884822303735;5731.598788084836;5752.252207213078;5758.596898217126;1939.3309308288617;1971.3001884331;1981.8216360527622;2034.806693364128;2039.2964427272716;29944;30338.696613033808;30340;30356.392872142434;30368;7148.320909513588;7177.712891484387;7199.604021778852;7230.240824713329;7263.854722905512;19095.522611934535;19325;19341.613167736567;19354.612907741765;19371.3220037298;7885.250901164381;8306.875396869053;8494.320454363637;8498.787530311793;8527;7643.273888980538;7691.961540192263;7855.057393112863;7864.4888082274465;7866;5502.752376143083;5653.604247702704;5689.146628005832;5839.620424672383;5872.412758724094;1632.4041724770611;1659.6514731906193;1663.2265996311774;1685.5449028762412;1690.6111594333372;912.8995810460844;922.4511415707643;937.437537477508;941.9387739796891;943.6366998705548;8136.633851476698;8247.587620618946;8262.091169971298;8266.380021498411;8304;781.7107670162077;791.4262159934117;792.9097490949944;794.7615715285391;816.6202715737211;4686.929696054562;5782.277215348082;5822.155787410802;5885.5585831062845;6028.276606807123;23663.526729465313;24323.756762432502;24417.877910610332;24461.266162014814;24647.753522464904;23207.767922320898;24265;24515.754842451348;24574.877125614257;24633;11833.467493962793;11953.820692689616;11969.22200057011;12012.219205751599;12049.939750301368;8923.955380223057;9076.954615227145;9134.497602631918;9162.541872906462;9265.119813617695;20466.283680071127;20584.794152058286;21181.36455906325;21315.893420532797;21583.13667453347;21655.675164872853;21678.24126155577;21957.780422195574;22057.66913496331;22068.779312207316;12182.573609923611;12344.81482777741;12345.567905123278;12366.319852407843;12373.195742276723;15328.386864525293;15406;15440.613984650474;15591.610209744847;15609.531714048597;12265.816012759637;12623.431945562656;12726.554570589984;12837.743245135232;12891.871081289068;12226.75546489083;12260.816087758869;12339.568115115928;12548.058895582686;12595.307258100893;10394.480275986321;10541.683749487527;10727.249092563758;10727.731806704895;10742.194335424718;7869.527828330319;8100.513969161869;8178.7955301117945;8194.180581941759;8316.293115085286;7885.250901164381;8002.679892804223;8030.678772849021;8098.676052957816;8124.796880078045 04:19:52 INFO - PID 11446 | |4;prototype.html;538.9703566303853;550.9449055094489;565.64929743559;568.817978246961;588.8675048114175;6060.636361818289;6132.620160463894;6187.628742275467;6194.349593292707;6280.968595157024;5989.161517387558;6076.453119219281;6090.8477288067825;6190.25716913971;6194.256689197303;4983.451820299764;4996.350474438318;5012.4736902625245;5048.394192696863;5079.5428411443145;4997.450280469146;5056.342675452204;5065.392152941652;5077.847664570068;5090.75276557244;4790.784414701329;4846.466888642264;4865.318855360252;4893.535114164149;4902.0931127741305;4856;4858.587020103296;4872.488388719169;4924.212126059813;4949.307097006422;4319.308910574325;4392.494863090754;4402.7578483183415;4410.941374070232;4432.822687092513;5888.646681199141;5918.911216331759;5929.9703501482645;5992.940070599282;6001.579889407743;5694.2312787773535;5696.430356964312;5720.856978575527;5752.741126649311;5772.30732312121;6481.64350960697;6531.7387304507765;6562.146920900253;6574.112494813235;6595.043718660815;4664.346991421204;4909.558139767402;4944.134776414113;4944.975275123637;4960.503949605047;6611.603303801788;6623.801285961429;6766.560173588701;6824.522283440161;6826.317368263183;5036.571891389273;5060.974695126501;5070.695758254443;5074.898502030012;5136.229565565195;5137.974310128426;5167.431582525919;5167.870803229949;5183.974080129575;5198.376194856566;5701.71491425427;5702.315722113373;5744.827655170351;5751.1085781703905;5794.79718209869;6570.244421891448;6594.724220623482;6600.537962342686;6626.469882409396;6636.369544893324;1728.8271172882862;1750.0598993690467;1757.3761314733085;1781.6169523552499;1791.8297761712618;1220.3741903841424;1226.2764968668528;1251.1117106854053;1264.0898553041795;1264.0961712375695;6042.546808989343;6057.363976782374;6057.72835186805;6078.513718902477;6118.357572454917;6626.271110177877;6643.933560664428;6671.666416679147;6705.463562914955;6710.758509675726;5918.644881307049;6009.703062310469;6045.576809623284;6048.183495228176;6072.544559158081;3360.8655653774063;3445.896623101311;3466.687998080185;3470.774399664014;3502.527158833576;6829.009793579903;6853.566983720807;6860.3825655690225;6866.382025617719;6888.793336199922;6654.73381064752;6805.319468053155;6807.625580593016;6813.7955861324235;6830.897536536956;6772.525923185428;6902.240753517109;6941.167059952737;6944.305569443015;6949.305069493112;6539.934600654123;6562.868742625216;6570.211574611078;6588.736450541925;6629.933700662931;6443.806685799434;6472.126262954441;6498.187726534184;6539.378759017885;6577.276499584946;6747.460203183636;6803.659817009031;6824.317568243136;6861.313868613099;6866.141732283465;4980.228064649985;5089.8727531812;5119.411267704113;5123.205903085028;5130.102232109441;6511.186101737283;6573.967130164318;6647.634380109141;6704.4301234395625;6777.220619628806;6415.792103948026;6449.161608990801;6449.935500644933;6450.967745161432;6460.512702609435;6405;6428.710708018057;6443.387878151568;6450.516211284079;6451.806445806634;6299.401556852092;6312.14786003902;6327.90508142369;6380.425761681471;6384.425401713868;6423;6427.485801135805;6442.872497313046;6461.967690161519;6510.902336465051;6260.874782504234;6289.716962736779;6302.338254483397;6312.337204593451;6345.683825403787 04:19:52 INFO - PID 11446 | |5;yui.html;911.6581282019242;945.6737425588173;951.3863558005087;954.851997940319;967.3325405470227;18791.906040469796;19753.506162345948;19778.40664780055;19804.207831686752;19926.202951881944;17342.219600117995;17409.3036278549;17525.298988040497;19544.511387215327;19816.207351705914;1015.5886865819355;1027.1885210683552;1027.2501074215827;1031.360556454999;1031.4275577054732;1036.0830664861576;1065.323519565078;1067.7597540553352;1069.0592278794688;1069.8234791259433;1138.0156164917328;1142.6115120858906;1143.0284258380393;1143.828425736138;1144.1361771862232;1077.7844431113808;1109.7170221593483;1113.6826004588654;1117.2570240789864;1134.075728281452;813.995930020352;817.3624572833199;818.2226884459787;818.3167055508658;819.5779173725537;20503.897480512653;20935.057922393527;21068.789312106837;21074.473138171514;21094.472638184016;22172.11311547536;22245.888770556205;22561.66157507639;22573.887130564406;22629.886850565643;18250.452486425427;18481.907590462095;18520;18626.161822717873;18663.533411664816;3753.7560058596378;4008.1382502762044;4015.5181378234506;4022.859199928018;4036.192761447722;152472.2376388122;153254;154674;154896;155571.2221438897;16921.83078169227;16922.153892305334;17072.2317495713;17236.224369903386;17400.912995435196;30508.389832203677;33768.66231337704;34114;34198.48702269468;34399.82800085984;9604;9708.5145742714;9716.12554870051;9716.659916902874;9726.562304696306;4658.091672123904;4714.693544919569;4877.56101950819;4884;4905.435874874435;4956.355673762388;5065.569426598707;5066.695998240118;5067.569256613229;5084.949150508522;1262.551794113095;1269.1623528471164;1292.3990344489669;1299.1815156451376;1301.3233118778182;661.2659947458318;717.9389751871149;725.1262229014026;733.9266073392617;742.3801126059693;11807.88192118085;12618.684532886751;13192.802107968388;13578.796318055238;13754.243516606683;627.0719335383658;637.2384999925046;640.3180612647516;642.097852517214;658.4140115297294;5891.936327628659;5942.197803296586;6078.939210607838;6099.176611157437;6137.508999280047;141865.29067354597;145736;147511;148487;150922;130053;131129.34435327954;133227;135619;137644;112303;112904.43547782209;113113.73896368609;113227;118959;11295.717607059889;11306.038986686224;11352.829707554229;11369.090472761995;11544.365059921785;54067.18899216436;54377;54554.454455454936;55389.16916246179;56346.7182664084;67143.66428167828;67358;67549;67683.66158169178;71440;17321.826781732023;17330.480085597454;17383.130843458028;17410.825891740922;17535.298588056336;18288.81711182871;18331.633367332845;18432.262709492006;18595;18617.441476755717;16104.436344727877;16357.918210409347;16377.099259540839;16524.834751652328;16548.089855058086;16500;16713.749293760848;16789.328426863278;16890.40883569069;16916.83083169202;17129;17260.136993150543;17317;17387.739183912505;17434.21546030406;12671.619851404472;13130.343482825629;13326.067175298023;13439.260840653467;13493.865061349261;12472.563460278847;12527.624171274876;12885.42015609281;12893.161944473579;12931.676708082374 04:19:52 INFO - PID 11446 | __end_tp_report 04:19:52 INFO - PID 11446 | __start_cc_report 04:19:52 INFO - PID 11446 | _x_x_mozilla_cycle_collect,363 04:19:52 INFO - PID 11446 | __end_cc_report 04:19:52 INFO - PID 11446 | __startTimestamp1505215192027__endTimestamp 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | ------- Summary: start ------- 04:19:52 INFO - PID 11446 | Number of tests: 6 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#0] dojo.html Cycles:165 Average:6269.26 Median:6506.93 stddev:742.88 (11.4%) stddev-sans-first:719.66 04:19:52 INFO - PID 11446 | Values: 3809.7 3869.2 3904.6 3935.8 3947.1 6203.7 6333.4 6347.1 6363.8 6364.5 6200.0 6286.5 6290.9 6303.1 6368.7 5534.7 5569.9 5635.9 5658.4 5706.3 5259.1 5501.5 5598.7 5664.5 5671.9 5586.7 5621.5 5654.0 5657.3 5664.0 5578.6 5594.4 5658.7 5692.7 5704.2 5518.4 5595.1 5608.4 5652.0 5657.5 6156.4 6280.1 6280.5 6307.7 6333.4 6809.3 6845.2 6889.3 6891.3 6916.4 6831.2 6867.0 6871.5 6946.9 6947.8 6426.0 6435.7 6446.7 6454.2 6466.8 6983.4 6986.0 6993.6 7019.1 7079.0 6657.8 6689.1 6705.8 6733.9 6798.8 6782.5 6825.9 6829.4 6843.5 6843.6 6709.3 6732.0 6798.4 6815.3 6851.6 6683.6 6732.4 6787.5 6796.7 6854.4 4970.0 4976.3 5010.7 5019.7 5036.9 4485.4 4488.9 4592.5 4637.0 4646.1 6234.4 6270.8 6308.2 6325.7 6339.5 6617.4 6638.4 6679.0 6734.2 6815.3 6321.7 6361.0 6374.1 6388.2 6394.0 5480.3 5507.6 5542.0 5580.7 5584.1 6934.8 7039.5 7057.6 7062.9 7151.1 6807.4 6808.6 6823.1 6872.7 6885.9 7063.4 7153.8 7155.8 7179.0 7184.4 6637.9 6745.4 6752.9 6842.0 6854.0 6706.3 6784.5 6784.7 6789.9 6793.8 6486.1 6506.9 6507.3 6524.5 6610.0 6410.4 6517.5 6533.3 6623.7 6624.9 6454.0 6543.9 6552.7 6590.2 6594.0 6563.1 6604.5 6668.2 6672.1 6713.4 6379.7 6411.6 6416.8 6458.5 6519.8 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#1] ext.html Cycles:180 Average:45077.79 Median:39758.51 stddev:68810.41 (173.1%) stddev-sans-first:68923.69 04:19:52 INFO - PID 11446 | Values: 955.4 979.0 980.1 982.6 983.4 44168.8 44647.6 44691.0 44752.3 44774.8 43135.1 43272.4 43322.4 43367.1 43396.8 7331.2 7435.6 7438.2 7440.9 7443.0 7387.9 7423.2 7454.1 7454.9 7467.4 7936.7 8082.4 8094.2 8097.4 8110.3 7992.6 8011.7 8021.3 8030.0 8034.4 7646.5 7766.0 7772.7 7775.6 7885.4 40756.6 41139.4 41176.6 41192.6 41195.0 3743.0 3785.8 3788.5 3789.0 3793.6 33937.8 33942.8 33980.7 33997.7 34017.0 5425.8 5462.8 5497.8 5506.9 5527.9 214626.0 216913.0 217640.0 217709.0 218791.0 47376.8 54670.5 55027.0 55093.7 55138.7 56925.1 57130.0 57132.7 57199.0 57346.0 17148.9 17297.0 17301.7 17303.9 17311.0 14251.8 14297.6 14305.4 14309.6 14315.5 14983.3 15053.2 15055.1 15154.5 15165.7 5664.8 5781.0 5788.2 5893.6 5964.4 1084.4 1090.3 1097.9 1101.8 1105.7 25928.7 26408.0 26539.5 26589.0 26758.5 1192.6 1207.7 1212.3 1217.5 1218.6 13833.4 13863.4 13915.5 14150.5 14229.3 301110.0 305019.0 305096.0 305200.0 305604.0 61200.1 61581.7 67447.0 67664.3 67859.7 1495.3 1518.0 1518.1 1519.3 1532.6 32096.5 32178.0 32355.7 32445.4 33068.5 43781.6 43983.3 44021.8 44055.3 44156.0 263043.0 263408.0 263491.0 263555.0 264293.0 38760.4 41415.8 41736.0 41933.6 41997.4 51403.2 51544.7 52326.7 52385.2 52396.0 37791.6 37886.6 38191.4 38295.6 38528.8 36978.8 37137.4 37583.6 37640.0 37908.8 43065.1 44150.6 44470.1 44522.8 44635.8 36005.3 36036.8 36241.8 36259.3 36671.4 27216.9 27575.0 27833.7 27871.7 27898.6 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#2] jquery.html Cycles:180 Average:40197.01 Median:12773.57 stddev:104837.81 (820.7%) stddev-sans-first:105089.71 04:19:52 INFO - PID 11446 | Values: 582.8 589.1 591.2 592.4 607.2 21746.8 22467.4 22597.2 22654.0 22675.8 24481.9 24969.4 25412.7 25578.8 25604.2 6567.6 6734.6 6739.4 6743.7 6748.4 6568.4 6662.0 6729.3 6744.1 6759.1 6763.4 6768.6 6774.1 6774.4 6780.6 6782.0 6795.8 6802.2 6809.7 6821.1 6082.5 6312.0 6326.8 6335.5 6344.3 28974.0 29399.4 29411.1 29467.1 29502.9 2292.0 2327.9 2328.9 2330.9 2332.0 19641.1 20149.8 20418.8 20617.6 20662.8 2417.2 2464.2 2464.4 2490.9 2536.9 141010.3 147137.0 154499.0 161413.2 161467.0 15093.2 15291.4 15475.0 15489.1 15932.9 24888.3 24917.9 24932.4 24958.0 24993.5 10118.6 10153.9 10181.9 10228.1 10304.8 9216.7 9227.5 9274.3 9295.3 9413.0 9337.3 9516.8 9584.7 9592.5 9979.8 2695.9 2702.5 2720.4 2874.2 2955.5 1029.7 1055.7 1057.3 1059.6 1061.8 19962.0 20549.5 20796.4 21319.9 21352.7 1121.0 1127.1 1128.6 1129.2 1134.4 11338.2 11463.1 11481.5 11586.2 11707.6 615283.0 623789.0 630059.0 631140.0 635494.0 128260.0 130008.3 130303.0 130659.0 132186.0 1197.9 1228.6 1236.8 1254.8 1258.8 17942.6 18500.2 18518.3 18693.8 18733.9 64285.4 64536.0 65423.3 65635.7 66478.3 79255.6 79625.2 79823.6 80164.6 80971.2 14703.3 14985.4 15014.8 15087.6 15095.8 23255.2 23455.4 23523.0 23668.2 23800.0 19197.9 19251.9 19420.9 19519.3 19533.0 16563.6 17149.1 17259.1 17605.3 17782.2 18773.6 19259.7 19905.5 20015.2 20301.8 14570.1 14756.0 14804.9 14892.3 14896.4 19229.0 19267.9 19275.5 19324.2 19389.9 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#3] mootools.html Cycles:180 Average:10263.70 Median:2733.53 stddev:7596.20 (277.9%) stddev-sans-first:7588.35 04:19:52 INFO - PID 11446 | Values: 1405.5 1466.0 1473.6 1478.9 1480.4 16106.0 16732.3 16748.8 16755.0 16781.2 16344.4 16388.8 16437.8 16453.8 16457.4 2767.6 2869.5 2888.7 2891.0 2892.0 2660.4 2748.4 2752.5 2753.0 2753.4 2813.4 2903.8 2905.7 2906.3 2906.8 2695.7 2696.2 2712.6 2718.7 2718.7 2764.7 2785.4 2868.7 2874.3 2877.7 16548.3 16698.9 16710.3 16736.7 16739.7 8358.0 8607.8 8609.4 8614.3 8640.7 5466.2 5575.9 5731.6 5752.3 5758.6 1939.3 1971.3 1981.8 2034.8 2039.3 29944.0 30338.7 30340.0 30356.4 30368.0 7148.3 7177.7 7199.6 7230.2 7263.9 19095.5 19325.0 19341.6 19354.6 19371.3 7885.3 8306.9 8494.3 8498.8 8527.0 7643.3 7692.0 7855.1 7864.5 7866.0 5502.8 5653.6 5689.1 5839.6 5872.4 1632.4 1659.7 1663.2 1685.5 1690.6 912.9 922.5 937.4 941.9 943.6 8136.6 8247.6 8262.1 8266.4 8304.0 781.7 791.4 792.9 794.8 816.6 4686.9 5782.3 5822.2 5885.6 6028.3 23663.5 24323.8 24417.9 24461.3 24647.8 23207.8 24265.0 24515.8 24574.9 24633.0 11833.5 11953.8 11969.2 12012.2 12049.9 8924.0 9077.0 9134.5 9162.5 9265.1 20466.3 20584.8 21181.4 21315.9 21583.1 21655.7 21678.2 21957.8 22057.7 22068.8 12182.6 12344.8 12345.6 12366.3 12373.2 15328.4 15406.0 15440.6 15591.6 15609.5 12265.8 12623.4 12726.6 12837.7 12891.9 12226.8 12260.8 12339.6 12548.1 12595.3 10394.5 10541.7 10727.2 10727.7 10742.2 7869.5 8100.5 8178.8 8194.2 8316.3 7885.3 8002.7 8030.7 8098.7 8124.8 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#4] prototype.html Cycles:180 Average:5524.24 Median:6077.48 stddev:1546.62 (25.4%) stddev-sans-first:1505.02 04:19:52 INFO - PID 11446 | Values: 539.0 550.9 565.6 568.8 588.9 6060.6 6132.6 6187.6 6194.3 6281.0 5989.2 6076.5 6090.8 6190.3 6194.3 4983.5 4996.4 5012.5 5048.4 5079.5 4997.5 5056.3 5065.4 5077.8 5090.8 4790.8 4846.5 4865.3 4893.5 4902.1 4856.0 4858.6 4872.5 4924.2 4949.3 4319.3 4392.5 4402.8 4410.9 4432.8 5888.6 5918.9 5930.0 5992.9 6001.6 5694.2 5696.4 5720.9 5752.7 5772.3 6481.6 6531.7 6562.1 6574.1 6595.0 4664.3 4909.6 4944.1 4945.0 4960.5 6611.6 6623.8 6766.6 6824.5 6826.3 5036.6 5061.0 5070.7 5074.9 5136.2 5138.0 5167.4 5167.9 5184.0 5198.4 5701.7 5702.3 5744.8 5751.1 5794.8 6570.2 6594.7 6600.5 6626.5 6636.4 1728.8 1750.1 1757.4 1781.6 1791.8 1220.4 1226.3 1251.1 1264.1 1264.1 6042.5 6057.4 6057.7 6078.5 6118.4 6626.3 6643.9 6671.7 6705.5 6710.8 5918.6 6009.7 6045.6 6048.2 6072.5 3360.9 3445.9 3466.7 3470.8 3502.5 6829.0 6853.6 6860.4 6866.4 6888.8 6654.7 6805.3 6807.6 6813.8 6830.9 6772.5 6902.2 6941.2 6944.3 6949.3 6539.9 6562.9 6570.2 6588.7 6629.9 6443.8 6472.1 6498.2 6539.4 6577.3 6747.5 6803.7 6824.3 6861.3 6866.1 4980.2 5089.9 5119.4 5123.2 5130.1 6511.2 6574.0 6647.6 6704.4 6777.2 6415.8 6449.2 6449.9 6451.0 6460.5 6405.0 6428.7 6443.4 6450.5 6451.8 6299.4 6312.1 6327.9 6380.4 6384.4 6423.0 6427.5 6442.9 6462.0 6510.9 6260.9 6289.7 6302.3 6312.3 6345.7 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | [#5] yui.html Cycles:180 Average:27698.20 Median:17479.76 stddev:41626.40 (238.1%) stddev-sans-first:41694.59 04:19:52 INFO - PID 11446 | Values: 911.7 945.7 951.4 954.9 967.3 18791.9 19753.5 19778.4 19804.2 19926.2 17342.2 17409.3 17525.3 19544.5 19816.2 1015.6 1027.2 1027.3 1031.4 1031.4 1036.1 1065.3 1067.8 1069.1 1069.8 1138.0 1142.6 1143.0 1143.8 1144.1 1077.8 1109.7 1113.7 1117.3 1134.1 814.0 817.4 818.2 818.3 819.6 20503.9 20935.1 21068.8 21074.5 21094.5 22172.1 22245.9 22561.7 22573.9 22629.9 18250.5 18481.9 18520.0 18626.2 18663.5 3753.8 4008.1 4015.5 4022.9 4036.2 152472.2 153254.0 154674.0 154896.0 155571.2 16921.8 16922.2 17072.2 17236.2 17400.9 30508.4 33768.7 34114.0 34198.5 34399.8 9604.0 9708.5 9716.1 9716.7 9726.6 4658.1 4714.7 4877.6 4884.0 4905.4 4956.4 5065.6 5066.7 5067.6 5084.9 1262.6 1269.2 1292.4 1299.2 1301.3 661.3 717.9 725.1 733.9 742.4 11807.9 12618.7 13192.8 13578.8 13754.2 627.1 637.2 640.3 642.1 658.4 5891.9 5942.2 6078.9 6099.2 6137.5 141865.3 145736.0 147511.0 148487.0 150922.0 130053.0 131129.3 133227.0 135619.0 137644.0 112303.0 112904.4 113113.7 113227.0 118959.0 11295.7 11306.0 11352.8 11369.1 11544.4 54067.2 54377.0 54554.5 55389.2 56346.7 67143.7 67358.0 67549.0 67683.7 71440.0 17321.8 17330.5 17383.1 17410.8 17535.3 18288.8 18331.6 18432.3 18595.0 18617.4 16104.4 16357.9 16377.1 16524.8 16548.1 16500.0 16713.7 16789.3 16890.4 16916.8 17129.0 17260.1 17317.0 17387.7 17434.2 12671.6 13130.3 13326.1 13439.3 13493.9 12472.6 12527.6 12885.4 12893.2 12931.7 04:19:52 INFO - PID 11446 | -------- Summary: end -------- 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | 04:19:52 INFO - PID 11446 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 04:19:52 INFO - PID 11446 | 04:19:52 INFO - TEST-INFO | 11446: exit 0 04:19:52 INFO - TEST-OK | dromaeo_css | took 1108715ms 04:19:52 INFO - TEST-START | kraken 04:19:52 INFO - Initialising browser for kraken test... 04:19:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55611/getInfo.html -profile /tmp/tmpb4giSQ/profile 04:19:52 INFO - TEST-INFO | started process 11822 (/builds/slave/test/build/application/firefox/firefox http://localhost:55611/getInfo.html) 04:19:58 INFO - TEST-INFO | 11822: exit 0 04:19:58 INFO - Browser initialized. 04:19:58 INFO - Running cycle 1/1 for kraken test... 04:19:58 INFO - Using env: {'DISPLAY': ':0', 04:19:58 INFO - 'HOME': '/home/cltbld', 04:19:58 INFO - 'JSGC_DISABLE_POISONING': '1', 04:19:58 INFO - 'LANG': 'en_US.UTF-8', 04:19:58 INFO - 'LANGUAGE': 'en_US:en', 04:19:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:19:58 INFO - 'LOGNAME': 'cltbld', 04:19:58 INFO - 'MAIL': '/var/mail/cltbld', 04:19:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:58 INFO - 'MOZ_CRASHREPORTER': '1', 04:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:19:58 INFO - 'MOZ_NO_REMOTE': '1', 04:19:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:58 INFO - 'NO_EM_RESTART': '1', 04:19:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:58 INFO - 'PWD': '/builds/slave/test', 04:19:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:58 INFO - 'RUST_BACKTRACE': 'full', 04:19:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:19:58 INFO - 'SHELL': '/bin/bash', 04:19:58 INFO - 'SHLVL': '1', 04:19:58 INFO - 'STYLO_FORCE_DISABLED': '1', 04:19:58 INFO - 'TERM': 'linux', 04:19:58 INFO - 'TMOUT': '86400', 04:19:58 INFO - 'USER': 'cltbld', 04:19:58 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152', 04:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:58 INFO - '_': '/tools/buildbot/bin/python'} 04:19:58 INFO - TEST-INFO | started process 12022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4giSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:58 INFO - PID 12022 | 04:19:58 INFO - PID 12022 | (/builds/slave/test/build/application/firefox/firefox:12073): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:58 INFO - PID 12022 | 04:20:09 INFO - PID 12022 | RSS: Main: 163487744 04:20:09 INFO - PID 12022 | 04:20:11 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:12 INFO - PID 12022 | RSS: Main: 168435712 04:20:12 INFO - PID 12022 | 04:20:15 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-dft) 04:20:15 INFO - PID 12022 | RSS: Main: 168992768 04:20:15 INFO - PID 12022 | 04:20:18 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-fft) 04:20:19 INFO - PID 12022 | RSS: Main: 163491840 04:20:19 INFO - PID 12022 | 04:20:21 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55611/tests/kraken/driver.html?testName=audio-oscillator) 04:20:22 INFO - PID 12022 | RSS: Main: 164851712 04:20:22 INFO - PID 12022 | 04:20:24 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:24 INFO - PID 12022 | RSS: Main: 164642816 04:20:24 INFO - PID 12022 | 04:20:27 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:28 INFO - PID 12022 | RSS: Main: 166105088 04:20:28 INFO - PID 12022 | 04:20:32 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55611/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:32 INFO - PID 12022 | RSS: Main: 167231488 04:20:32 INFO - PID 12022 | 04:20:35 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55611/tests/kraken/driver.html?testName=json-parse-financial) 04:20:36 INFO - PID 12022 | RSS: Main: 167489536 04:20:36 INFO - PID 12022 | 04:20:37 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:38 INFO - PID 12022 | RSS: Main: 167559168 04:20:38 INFO - PID 12022 | 04:20:39 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:40 INFO - PID 12022 | RSS: Main: 167419904 04:20:40 INFO - PID 12022 | 04:20:42 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:43 INFO - PID 12022 | RSS: Main: 164884480 04:20:43 INFO - PID 12022 | 04:20:45 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:46 INFO - PID 12022 | RSS: Main: 164413440 04:20:46 INFO - PID 12022 | 04:20:49 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:49 INFO - PID 12022 | RSS: Main: 164945920 04:20:49 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | Cycle 1(1): loaded http://localhost:55611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55611/tests/kraken/driver.html?testName=ai-astar) 04:20:51 INFO - PID 12022 | RSS: Main: 166694912 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | __start_tp_report 04:20:51 INFO - PID 12022 | _x_x_mozilla_page_load 04:20:51 INFO - PID 12022 | _x_x_mozilla_page_load_details 04:20:51 INFO - PID 12022 | |i|pagename|runs| 04:20:51 INFO - PID 12022 | |0;ai-astar;105;105;107;108;108;106;106;106;108;106 04:20:51 INFO - PID 12022 | |1;audio-beat-detection;117;112;111;134;112;112;148;115;115;144 04:20:51 INFO - PID 12022 | |2;audio-dft;162;162;164;163;162;163;161;161;161;162 04:20:51 INFO - PID 12022 | |3;audio-fft;73;73;75;73;74;81;73;74;76;74 04:20:51 INFO - PID 12022 | |4;audio-oscillator;80;79;79;79;78;78;78;78;78;78 04:20:51 INFO - PID 12022 | |5;imaging-gaussian-blur;113;113;113;114;114;114;114;113;112;115 04:20:51 INFO - PID 12022 | |6;imaging-darkroom;150;151;150;148;151;150;150;149;150;152 04:20:51 INFO - PID 12022 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;95 04:20:51 INFO - PID 12022 | |8;json-parse-financial;44;45;47;51;44;44;43;44;45;44 04:20:51 INFO - PID 12022 | |9;json-stringify-tinderbox;36;36;37;36;37;37;36;38;36;36 04:20:51 INFO - PID 12022 | |10;stanford-crypto-aes;81;75;74;73;76;73;71;73;72;74 04:20:51 INFO - PID 12022 | |11;stanford-crypto-ccm;106;111;107;109;112;106;106;115;108;106 04:20:51 INFO - PID 12022 | |12;stanford-crypto-pbkdf2;159;157;153;151;152;159;154;152;153;153 04:20:51 INFO - PID 12022 | |13;stanford-crypto-sha256-iterative;63;59;59;58;61;73;71;58;62;59 04:20:51 INFO - PID 12022 | __end_tp_report 04:20:51 INFO - PID 12022 | __start_cc_report 04:20:51 INFO - PID 12022 | _x_x_mozilla_cycle_collect,885 04:20:51 INFO - PID 12022 | __end_cc_report 04:20:51 INFO - PID 12022 | __startTimestamp1505215251668__endTimestamp 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | ------- Summary: start ------- 04:20:51 INFO - PID 12022 | Number of tests: 14 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#0] ai-astar Cycles:10 Average:106.50 Median:106.50 stddev:1.18 (1.1%) stddev-sans-first:1.12 04:20:51 INFO - PID 12022 | Values: 105.0 105.0 107.0 108.0 108.0 106.0 106.0 106.0 108.0 106.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:116.00 stddev:14.33 (12.4%) stddev-sans-first:15.08 04:20:51 INFO - PID 12022 | Values: 117.0 112.0 111.0 134.0 112.0 112.0 148.0 115.0 115.0 144.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:20:51 INFO - PID 12022 | Values: 162.0 162.0 164.0 163.0 162.0 163.0 161.0 161.0 161.0 162.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#3] audio-fft Cycles:10 Average:74.60 Median:74.00 stddev:2.46 (3.3%) stddev-sans-first:2.54 04:20:51 INFO - PID 12022 | Values: 73.0 73.0 75.0 73.0 74.0 81.0 73.0 74.0 76.0 74.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.50 stddev:0.71 (0.9%) stddev-sans-first:0.50 04:20:51 INFO - PID 12022 | Values: 80.0 79.0 79.0 79.0 78.0 78.0 78.0 78.0 78.0 78.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 04:20:51 INFO - PID 12022 | Values: 113.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 112.0 115.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 04:20:51 INFO - PID 12022 | Values: 150.0 151.0 150.0 148.0 151.0 150.0 150.0 149.0 150.0 152.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:20:51 INFO - PID 12022 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:44.50 stddev:2.33 (5.2%) stddev-sans-first:2.44 04:20:51 INFO - PID 12022 | Values: 44.0 45.0 47.0 51.0 44.0 44.0 43.0 44.0 45.0 44.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#9] json-stringify-tinderbox Cycles:10 Average:36.50 Median:36.50 stddev:0.71 (1.9%) stddev-sans-first:0.73 04:20:51 INFO - PID 12022 | Values: 36.0 36.0 37.0 36.0 37.0 37.0 36.0 38.0 36.0 36.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.78 (3.8%) stddev-sans-first:1.51 04:20:51 INFO - PID 12022 | Values: 81.0 75.0 74.0 73.0 76.0 73.0 71.0 73.0 72.0 74.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#11] stanford-crypto-ccm Cycles:10 Average:108.60 Median:108.50 stddev:3.13 (2.9%) stddev-sans-first:3.18 04:20:51 INFO - PID 12022 | Values: 106.0 111.0 107.0 109.0 112.0 106.0 106.0 115.0 108.0 106.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:153.50 stddev:2.95 (1.9%) stddev-sans-first:2.59 04:20:51 INFO - PID 12022 | Values: 159.0 157.0 153.0 151.0 152.0 159.0 154.0 152.0 153.0 153.0 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:61.50 stddev:5.40 (8.8%) stddev-sans-first:5.72 04:20:51 INFO - PID 12022 | Values: 63.0 59.0 59.0 58.0 61.0 73.0 71.0 58.0 62.0 59.0 04:20:51 INFO - PID 12022 | -------- Summary: end -------- 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | 04:20:51 INFO - PID 12022 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 04:20:51 INFO - PID 12022 | 04:20:52 INFO - PID 12022 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:20:52 INFO - TEST-INFO | 12022: exit 0 04:20:52 INFO - TEST-OK | kraken | took 59938ms 04:20:52 INFO - SUITE-END | took 1168s 04:20:52 INFO - Completed test suite (00:19:28) 04:20:52 INFO - javascript benchmark 04:20:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8998.372824961229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3809.657130858222, 3869.2454971280577, 3904.648581627654, 3935.8032098395083, 3947.092168801176, 6203.689815509223, 6333.398327158919, 6347.1431356766825, 6363.840903977403, 6364.45902098321, 6199.969000155004, 6286.528510361718, 6290.874182516359, 6303.117563541108, 6368.745250189999, 5534.723263836802, 5569.8607534811545, 5635.8591035224035, 5658.405867383906, 5706.258186435757, 5259.077888805902, 5501.477359650827, 5598.664080155204, 5664.490195882369, 5671.914921276184, 5586.692731899744, 5621.4940655341015, 5653.971730141323, 5657.264555607745, 5664.0, 5578.609497335188, 5594.412586678381, 5658.74535645897, 5692.658440493584, 5704.172894930211, 5518.365387980353, 5595.104783234663, 5608.4391560844, 5652.010898092817, 5657.462541058593, 6156.384361563808, 6280.089387038899, 6280.528960327993, 6307.716152773136, 6333.398327158912, 6809.285025072395, 6845.247022827485, 6889.311068893121, 6891.345322194384, 6916.412104971084, 6831.180258368978, 6867.0, 6871.4502839772695, 6946.895796563055, 6947.826304342381, 6425.967870160666, 6435.74257029723, 6446.742130314782, 6454.22549294083, 6466.838329041811, 6983.406410455066, 6986.0, 6993.580385176906, 7019.0875186226485, 7078.964605176941, 6657.7669781557415, 6689.130413046273, 6705.832354191184, 6733.8989915151315, 6798.76204332846, 6782.491313151533, 6825.9317406826285, 6829.351211634887, 6843.452523798084, 6843.589384636938, 6709.329067093349, 6732.0, 6798.388145066968, 6815.318468153145, 6851.588904665637, 6683.565568238049, 6732.360425759545, 6787.524873258923, 6796.660166991631, 6854.383105520527, 4969.950300497021, 4976.303317535548, 5010.749462526859, 5019.723915184627, 5036.899262014739, 4485.394471746337, 4488.865334039984, 4592.540745925381, 4636.976815115971, 4646.09401166776, 6234.407731265523, 6270.811875643738, 6308.243010838729, 6325.652089135142, 6339.524535659844, 6617.437517810944, 6638.435732962752, 6678.966605166943, 6734.225564060098, 6815.318468153145, 6321.715522801485, 6360.9822428411235, 6374.075759014917, 6388.169537960035, 6394.0408938659575, 5480.26016487777, 5507.642003269774, 5541.972290138524, 5580.665160090408, 5584.078627026495, 6934.826629334307, 7039.507234493536, 7057.576545407292, 7062.858742825115, 7151.141862976476, 6807.3873351398615, 6808.5914845109455, 6823.112995310578, 6872.725090996304, 6885.862282754217, 7063.434925205868, 7153.82115447118, 7155.821104472429, 7179.030830837979, 7184.353408193288, 6637.867242655023, 6745.3591908768585, 6752.932470675427, 6842.042114104129, 6854.040434339297, 6706.262311145868, 6784.525083244323, 6784.660766961533, 6789.93210067893, 6793.796186114425, 6486.091947127312, 6506.934930650822, 6507.28419873823, 6524.510661700297, 6609.966950165219, 6410.391012853772, 6517.543771936109, 6533.281339052605, 6623.735050598115, 6624.867502649824, 6454.031895215755, 6543.901841472287, 6552.737890484327, 6590.176227971504, 6594.043863639841, 6563.146790917342, 6604.471642268511, 6668.166479190101, 6672.132622759011, 6713.362230588086, 6379.7129129190225, 6411.6153030818305, 6416.839579010375, 6458.483321334376, 6519.837004074936], "value": 6219.146523461028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.4458414119811, 979.0258692600863, 980.14727187347, 982.5971351745782, 983.4381436358291, 44168.77915610422, 44647.55352446475, 44691.0, 44752.3287150693, 44774.77612611932, 43135.137297254034, 43272.35091473631, 43322.35016474756, 43367.13265734683, 43396.783016084955, 7331.230220826817, 7435.591042492661, 7438.181800001996, 7440.851182976337, 7443.0, 7387.889181662279, 7423.183449820515, 7454.068241469817, 7454.925450745504, 7467.365273951721, 7936.682532698714, 8082.39382046346, 8094.231048050426, 8097.35221182304, 8110.270075693186, 7992.640331185082, 8011.67953281868, 8021.278084972322, 8029.959850200741, 8034.357251419901, 7646.541207527511, 7766.0, 7772.727954521564, 7775.572343521104, 7885.369170466349, 40756.59243407587, 41139.38290925638, 41176.588234117575, 41192.58807411917, 41195.0, 3742.9812850935573, 3785.8107094645434, 3788.5074940257864, 3789.0148561373967, 3793.6206379361843, 33937.83031084829, 33942.83028584866, 33980.660193398, 33997.660023399694, 34017.0, 5425.83722488326, 5462.754176062087, 5497.780088796443, 5506.944930550723, 5527.861803454945, 214626.0, 216913.0, 217640.0, 217709.0, 218791.0, 47376.7631161842, 54670.453295467334, 55027.0, 55093.72453137708, 55138.72430637821, 56925.14612280819, 57130.0, 57132.714336428886, 57199.0, 57346.0, 17148.914255428645, 17297.0, 17301.7404738929, 17303.91348043277, 17311.0, 14251.78622320666, 14297.571072867831, 14305.356258968372, 14309.57071287863, 14315.498957536436, 14983.250837458083, 15053.172075535951, 15055.096694198382, 15154.469593564392, 15165.696686066216, 5664.801731939362, 5780.971095144498, 5788.179801331185, 5893.5874488785375, 5964.373740757244, 1084.4144162152506, 1090.2804149261449, 1097.939613321259, 1101.8347247912877, 1105.7401510644993, 25928.74071259301, 26408.0, 26539.46921061568, 26589.0, 26758.464830703666, 1192.6171320397505, 1207.704112492445, 1212.2786941769632, 1217.549506682533, 1218.585680868509, 13833.446662133603, 13863.445462181602, 13915.512957046454, 14150.504732334319, 14229.28853557318, 301110.0, 305019.0, 305096.0, 305200.0, 305604.0, 61200.08199877005, 61581.69209154015, 67447.0, 67664.32335676679, 67859.66070169618, 1495.28973737476, 1517.9696406071816, 1518.1270769307691, 1519.3390874969423, 1532.5785409012387, 32096.518552222202, 32178.0, 32355.676443236207, 32445.35109297848, 33068.503972440914, 43781.56218437902, 43983.340249895635, 44021.77989110034, 44055.33916991312, 44156.025957663966, 263043.0, 263408.0, 263491.0, 263555.0, 264293.0, 38760.41859372168, 41415.7929210352, 41736.0, 41933.58066419297, 41997.37003944882, 51403.2289515665, 51544.74227628838, 52326.73836630792, 52385.214221787464, 52396.0, 37791.62208377881, 37886.62113378941, 38191.427128592535, 38295.617043830316, 38528.80735596304, 36978.815105924295, 37137.44293835541, 37583.62416375911, 37640.0, 37908.81045594755, 43065.13869722651, 44150.55849441465, 44470.11059778851, 44522.77738611286, 44635.77682111569, 36005.27989440144, 36036.81981590075, 36241.818790905876, 36259.27481450409, 36671.449928250564, 27216.863915680296, 27575.0, 27833.72166278311, 27871.72128278691, 27898.581521277603], "value": 19220.060912461744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7552427980248, 589.1222079102138, 591.160552016137, 592.3987153039666, 607.1560530862101, 21746.782532174675, 22467.438314042138, 22597.209097681585, 22653.99999999996, 22675.773242267594, 24481.877590612068, 24969.37576560587, 25412.745872541316, 25578.84895179717, 25604.23187304379, 6567.605943643384, 6734.562253453534, 6739.393454589086, 6743.662816859162, 6748.358905903931, 6568.376004279586, 6662.034005069262, 6729.25978142404, 6744.089547911019, 6759.1213142291435, 6763.391294783469, 6768.593884366929, 6774.085498457719, 6774.356436138559, 6780.627065511395, 6782.0, 6795.796126116175, 6802.217744959344, 6809.727610895583, 6821.079154314154, 6082.452579267843, 6311.968440157816, 6326.778562750282, 6335.461485773715, 6344.270408902989, 28974.0, 29399.412011759858, 29411.11766647004, 29467.11598652044, 29502.852485737432, 2291.9541609167723, 2327.93016209514, 2328.871912044837, 2330.906763729449, 2332.0205513684296, 19641.116149773152, 20149.79850201494, 20418.795812041837, 20617.5876482471, 20662.793372066237, 2417.226487523993, 2464.1621848571394, 2464.371585245769, 2490.887910044052, 2536.9238922832346, 141010.29494852564, 147137.0, 154499.0, 161413.19293403576, 161467.0, 15093.24533773307, 15291.388344466319, 15475.0, 15489.14809685478, 15932.920335398248, 24888.253352399457, 24917.87541062283, 24932.376690582518, 24958.0, 24993.500129997297, 10118.645847395306, 10153.94923025395, 10181.949090254502, 10228.07947284748, 10304.793904122025, 9216.723498295061, 9227.53862306882, 9274.30442716799, 9295.256379489625, 9413.0, 9337.253019758538, 9516.762080948032, 9584.712458626253, 9592.472414017297, 9979.750506237402, 2695.878685459159, 2702.4730177615174, 2720.3743139078124, 2874.152125123094, 2955.5123404638425, 1029.7271223125877, 1055.6569115037644, 1057.3285963413289, 1059.586761163147, 1061.766411389493, 19962.0, 20549.48626284325, 20796.376108716762, 21319.8934005329, 21352.679709804364, 1121.0303087829132, 1127.1264769803468, 1128.5598616539555, 1129.2377645089532, 1134.4271143072694, 11338.206325557132, 11463.140264480196, 11481.483333250024, 11586.246893951866, 11707.590234341757, 615283.0, 623789.0, 630059.0, 631140.0, 635494.0, 128260.0, 130008.3499582496, 130303.0, 130659.0, 132186.0, 1197.8981786548068, 1228.5515786737776, 1236.8330275412884, 1254.7866862633375, 1258.8300579421843, 17942.5514362142, 18500.16749246314, 18518.2592696296, 18693.81306186975, 18733.90633046826, 64285.35714642794, 64536.0, 65423.34576654363, 65635.7027504035, 66478.33521664915, 79255.60372198332, 79625.2037479641, 79823.60088199521, 80164.59917700374, 80971.19028809636, 14703.264836758333, 14985.40058397652, 15014.774778378114, 15087.622809429851, 15095.849041509884, 23255.18606848752, 23455.41361465977, 23523.0, 23668.171613994116, 23800.047998080576, 19197.90401047986, 19251.903740481208, 19420.902895485997, 19519.316823911096, 19533.0, 16563.585910352336, 17149.142542873054, 17259.13704314754, 17605.29578816884, 17782.199801009243, 18773.624527509648, 19259.711104333164, 19905.502362440475, 20015.199392024155, 20301.79698203058, 14570.125792452487, 14756.040857344238, 14804.925975370053, 14892.255387230378, 14896.40414383456, 19229.0, 19267.903660481606, 19275.51811204731, 19324.227030918606, 19389.903050484656], "value": 12599.922617378665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.4588983241451, 1465.9549927850649, 1473.6389584551787, 1478.874295684867, 1480.4448331875553, 16106.0, 16732.330706771743, 16748.83251167488, 16755.0, 16781.160941952898, 16344.427945021896, 16388.75416868748, 16437.753433698475, 16453.753193702105, 16457.423990160347, 2767.5571908494594, 2869.4834929712642, 2888.696686847882, 2891.0459548348995, 2891.971080289202, 2660.3881107345323, 2748.367875388662, 2752.477029364424, 2752.9862350688218, 2753.3529620539257, 2813.4091840713477, 2903.840288784116, 2905.7239562241552, 2906.258903979482, 2906.8110572812807, 2695.7034726180104, 2696.1776658119265, 2712.6066720325443, 2718.673759148895, 2718.687350954636, 2764.7373499517716, 2785.4429114177246, 2868.727470890262, 2874.3101655602713, 2877.654681438241, 16548.338066477325, 16698.916505417394, 16710.331586736516, 16736.66526669472, 16739.66520669592, 8358.0, 8607.784805379853, 8609.440386374865, 8614.310855131636, 8640.697575584825, 5466.234727138204, 5575.8884822303735, 5731.598788084836, 5752.252207213078, 5758.596898217126, 1939.3309308288617, 1971.3001884331, 1981.8216360527622, 2034.806693364128, 2039.2964427272716, 29944.0, 30338.696613033808, 30340.0, 30356.392872142434, 30368.0, 7148.320909513588, 7177.712891484387, 7199.604021778852, 7230.240824713329, 7263.854722905512, 19095.522611934535, 19325.0, 19341.613167736567, 19354.612907741765, 19371.3220037298, 7885.250901164381, 8306.875396869053, 8494.320454363637, 8498.787530311793, 8527.0, 7643.273888980538, 7691.961540192263, 7855.057393112863, 7864.4888082274465, 7866.0, 5502.752376143083, 5653.604247702704, 5689.146628005832, 5839.620424672383, 5872.412758724094, 1632.4041724770611, 1659.6514731906193, 1663.2265996311774, 1685.5449028762412, 1690.6111594333372, 912.8995810460844, 922.4511415707643, 937.437537477508, 941.9387739796891, 943.6366998705548, 8136.633851476698, 8247.587620618946, 8262.091169971298, 8266.380021498411, 8304.0, 781.7107670162077, 791.4262159934117, 792.9097490949944, 794.7615715285391, 816.6202715737211, 4686.929696054562, 5782.277215348082, 5822.155787410802, 5885.5585831062845, 6028.276606807123, 23663.526729465313, 24323.756762432502, 24417.877910610332, 24461.266162014814, 24647.753522464904, 23207.767922320898, 24265.0, 24515.754842451348, 24574.877125614257, 24633.0, 11833.467493962793, 11953.820692689616, 11969.22200057011, 12012.219205751599, 12049.939750301368, 8923.955380223057, 9076.954615227145, 9134.497602631918, 9162.541872906462, 9265.119813617695, 20466.283680071127, 20584.794152058286, 21181.36455906325, 21315.893420532797, 21583.13667453347, 21655.675164872853, 21678.24126155577, 21957.780422195574, 22057.66913496331, 22068.779312207316, 12182.573609923611, 12344.81482777741, 12345.567905123278, 12366.319852407843, 12373.195742276723, 15328.386864525293, 15406.0, 15440.613984650474, 15591.610209744847, 15609.531714048597, 12265.816012759637, 12623.431945562656, 12726.554570589984, 12837.743245135232, 12891.871081289068, 12226.75546489083, 12260.816087758869, 12339.568115115928, 12548.058895582686, 12595.307258100893, 10394.480275986321, 10541.683749487527, 10727.249092563758, 10727.731806704895, 10742.194335424718, 7869.527828330319, 8100.513969161869, 8178.7955301117945, 8194.180581941759, 8316.293115085286, 7885.250901164381, 8002.679892804223, 8030.678772849021, 8098.676052957816, 8124.796880078045], "value": 7165.5023311693785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9703566303853, 550.9449055094489, 565.64929743559, 568.817978246961, 588.8675048114175, 6060.636361818289, 6132.620160463894, 6187.628742275467, 6194.349593292707, 6280.968595157024, 5989.161517387558, 6076.453119219281, 6090.8477288067825, 6190.25716913971, 6194.256689197303, 4983.451820299764, 4996.350474438318, 5012.4736902625245, 5048.394192696863, 5079.5428411443145, 4997.450280469146, 5056.342675452204, 5065.392152941652, 5077.847664570068, 5090.75276557244, 4790.784414701329, 4846.466888642264, 4865.318855360252, 4893.535114164149, 4902.0931127741305, 4856.0, 4858.587020103296, 4872.488388719169, 4924.212126059813, 4949.307097006422, 4319.308910574325, 4392.494863090754, 4402.7578483183415, 4410.941374070232, 4432.822687092513, 5888.646681199141, 5918.911216331759, 5929.9703501482645, 5992.940070599282, 6001.579889407743, 5694.2312787773535, 5696.430356964312, 5720.856978575527, 5752.741126649311, 5772.30732312121, 6481.64350960697, 6531.7387304507765, 6562.146920900253, 6574.112494813235, 6595.043718660815, 4664.346991421204, 4909.558139767402, 4944.134776414113, 4944.975275123637, 4960.503949605047, 6611.603303801788, 6623.801285961429, 6766.560173588701, 6824.522283440161, 6826.317368263183, 5036.571891389273, 5060.974695126501, 5070.695758254443, 5074.898502030012, 5136.229565565195, 5137.974310128426, 5167.431582525919, 5167.870803229949, 5183.974080129575, 5198.376194856566, 5701.71491425427, 5702.315722113373, 5744.827655170351, 5751.1085781703905, 5794.79718209869, 6570.244421891448, 6594.724220623482, 6600.537962342686, 6626.469882409396, 6636.369544893324, 1728.8271172882862, 1750.0598993690467, 1757.3761314733085, 1781.6169523552499, 1791.8297761712618, 1220.3741903841424, 1226.2764968668528, 1251.1117106854053, 1264.0898553041795, 1264.0961712375695, 6042.546808989343, 6057.363976782374, 6057.72835186805, 6078.513718902477, 6118.357572454917, 6626.271110177877, 6643.933560664428, 6671.666416679147, 6705.463562914955, 6710.758509675726, 5918.644881307049, 6009.703062310469, 6045.576809623284, 6048.183495228176, 6072.544559158081, 3360.8655653774063, 3445.896623101311, 3466.687998080185, 3470.774399664014, 3502.527158833576, 6829.009793579903, 6853.566983720807, 6860.3825655690225, 6866.382025617719, 6888.793336199922, 6654.73381064752, 6805.319468053155, 6807.625580593016, 6813.7955861324235, 6830.897536536956, 6772.525923185428, 6902.240753517109, 6941.167059952737, 6944.305569443015, 6949.305069493112, 6539.934600654123, 6562.868742625216, 6570.211574611078, 6588.736450541925, 6629.933700662931, 6443.806685799434, 6472.126262954441, 6498.187726534184, 6539.378759017885, 6577.276499584946, 6747.460203183636, 6803.659817009031, 6824.317568243136, 6861.313868613099, 6866.141732283465, 4980.228064649985, 5089.8727531812, 5119.411267704113, 5123.205903085028, 5130.102232109441, 6511.186101737283, 6573.967130164318, 6647.634380109141, 6704.4301234395625, 6777.220619628806, 6415.792103948026, 6449.161608990801, 6449.935500644933, 6450.967745161432, 6460.512702609435, 6405.0, 6428.710708018057, 6443.387878151568, 6450.516211284079, 6451.806445806634, 6299.401556852092, 6312.14786003902, 6327.90508142369, 6380.425761681471, 6384.425401713868, 6423.0, 6427.485801135805, 6442.872497313046, 6461.967690161519, 6510.902336465051, 6260.874782504234, 6289.716962736779, 6302.338254483397, 6312.337204593451, 6345.683825403787], "value": 5079.721897765544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.6581282019242, 945.6737425588173, 951.3863558005087, 954.851997940319, 967.3325405470227, 18791.906040469796, 19753.506162345948, 19778.40664780055, 19804.207831686752, 19926.202951881944, 17342.219600117995, 17409.3036278549, 17525.298988040497, 19544.511387215327, 19816.207351705914, 1015.5886865819355, 1027.1885210683552, 1027.2501074215827, 1031.360556454999, 1031.4275577054732, 1036.0830664861576, 1065.323519565078, 1067.7597540553352, 1069.0592278794688, 1069.8234791259433, 1138.0156164917328, 1142.6115120858906, 1143.0284258380393, 1143.828425736138, 1144.1361771862232, 1077.7844431113808, 1109.7170221593483, 1113.6826004588654, 1117.2570240789864, 1134.075728281452, 813.995930020352, 817.3624572833199, 818.2226884459787, 818.3167055508658, 819.5779173725537, 20503.897480512653, 20935.057922393527, 21068.789312106837, 21074.473138171514, 21094.472638184016, 22172.11311547536, 22245.888770556205, 22561.66157507639, 22573.887130564406, 22629.886850565643, 18250.452486425427, 18481.907590462095, 18520.0, 18626.161822717873, 18663.533411664816, 3753.7560058596378, 4008.1382502762044, 4015.5181378234506, 4022.859199928018, 4036.192761447722, 152472.2376388122, 153254.0, 154674.0, 154896.0, 155571.2221438897, 16921.83078169227, 16922.153892305334, 17072.2317495713, 17236.224369903386, 17400.912995435196, 30508.389832203677, 33768.66231337704, 34114.0, 34198.48702269468, 34399.82800085984, 9604.0, 9708.5145742714, 9716.12554870051, 9716.659916902874, 9726.562304696306, 4658.091672123904, 4714.693544919569, 4877.56101950819, 4884.0, 4905.435874874435, 4956.355673762388, 5065.569426598707, 5066.695998240118, 5067.569256613229, 5084.949150508522, 1262.551794113095, 1269.1623528471164, 1292.3990344489669, 1299.1815156451376, 1301.3233118778182, 661.2659947458318, 717.9389751871149, 725.1262229014026, 733.9266073392617, 742.3801126059693, 11807.88192118085, 12618.684532886751, 13192.802107968388, 13578.796318055238, 13754.243516606683, 627.0719335383658, 637.2384999925046, 640.3180612647516, 642.097852517214, 658.4140115297294, 5891.936327628659, 5942.197803296586, 6078.939210607838, 6099.176611157437, 6137.508999280047, 141865.29067354597, 145736.0, 147511.0, 148487.0, 150922.0, 130053.0, 131129.34435327954, 133227.0, 135619.0, 137644.0, 112303.0, 112904.43547782209, 113113.73896368609, 113227.0, 118959.0, 11295.717607059889, 11306.038986686224, 11352.829707554229, 11369.090472761995, 11544.365059921785, 54067.18899216436, 54377.0, 54554.454455454936, 55389.16916246179, 56346.7182664084, 67143.66428167828, 67358.0, 67549.0, 67683.66158169178, 71440.0, 17321.826781732023, 17330.480085597454, 17383.130843458028, 17410.825891740922, 17535.298588056336, 18288.81711182871, 18331.633367332845, 18432.262709492006, 18595.0, 18617.441476755717, 16104.436344727877, 16357.918210409347, 16377.099259540839, 16524.834751652328, 16548.089855058086, 16500.0, 16713.749293760848, 16789.328426863278, 16890.40883569069, 16916.83083169202, 17129.0, 17260.136993150543, 17317.0, 17387.739183912505, 17434.21546030406, 12671.619851404472, 13130.343482825629, 13326.067175298023, 13439.260840653467, 13493.865061349261, 12472.563460278847, 12527.624171274876, 12885.42015609281, 12893.161944473579, 12931.676708082374], "value": 9683.12707526816, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1382.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 107.0, 108.0, 108.0, 106.0, 106.0, 106.0, 108.0, 106.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 111.0, 134.0, 112.0, 112.0, 148.0, 115.0, 115.0, 144.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 73.0, 74.0, 81.0, 73.0, 74.0, 76.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 148.0, 151.0, 150.0, 150.0, 149.0, 150.0, 152.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 47.0, 51.0, 44.0, 44.0, 43.0, 44.0, 45.0, 44.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 36.0, 37.0, 37.0, 36.0, 38.0, 36.0, 36.0], "value": 36.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 74.0, 73.0, 76.0, 73.0, 71.0, 73.0, 72.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 107.0, 109.0, 112.0, 106.0, 106.0, 115.0, 108.0, 106.0], "value": 108.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 153.0, 151.0, 152.0, 159.0, 154.0, 152.0, 153.0, 153.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 58.0, 61.0, 73.0, 71.0, 58.0, 62.0, 59.0], "value": 62.3, "unit": "score"}]}]} 04:20:52 INFO - Return code: 0 04:20:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:52 INFO - # TBPL SUCCESS # 04:20:52 INFO - Running post-action listener: _package_coverage_data 04:20:52 INFO - Running post-action listener: _resource_record_post_action 04:20:52 INFO - [mozharness: 2017-09-12 11:20:52.948160Z] Finished run-tests step (success) 04:20:52 INFO - Running post-run listener: _resource_record_post_run 04:20:53 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 295976960; Read time: 356; Write time: 174500 04:20:53 INFO - TinderboxPrint: CPU usage
13.1% 04:20:53 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 356 04:20:53 INFO - TinderboxPrint: I/O write bytes / time
295,976,960 / 174,500 04:20:53 INFO - TinderboxPrint: CPU idle
8,221.0 (86.9%) 04:20:53 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 04:20:53 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13295616; Read time: 0; Write time: 4588 04:20:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:53 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 16384; Write bytes: 282681344; Read time: 356; Write time: 169912 04:20:53 INFO - Running post-run listener: _upload_blobber_files 04:20:53 INFO - Blob upload gear active. 04:20:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:20:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:20:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:00 INFO - (blobuploader) - INFO - Done attempting. 04:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:01 INFO - (blobuploader) - INFO - Done attempting. 04:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:04 INFO - (blobuploader) - INFO - Done attempting. 04:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:05 INFO - (blobuploader) - INFO - Done attempting. 04:21:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:05 INFO - Return code: 0 04:21:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a9455531cec2c4b0cf83e47c79c32eb29c23b65a510adca3732d1b09591d730298e17f60d104a76be6536219fb42fe28d23a8c2bfd2900fc0500a06fb2af8b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8472ebeb73edbad53f762cf73bf1df899ae73d227dfedf5689c16c3e7b7c6d1a50c08815e59a00cf11411e17c41ebbc86ce90342cd2aca7d93b9773301596ad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40e4095d2bf6c1862acdb4e93c0ad07eb1840307c8aaa49cbb688148aeabe49abd49fb2d21c98dc2064c340541f2c6a46b86bdff0e20414dfef6c1348ae68f65", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f59a7467de4b369a3e5d91539bc08c58c805cd49e1f68e65853580073779fa31899a622452374430af2b8c2d33a29ffc6c7ac8f0045b8bf32e264617a9260a"} 04:21:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:05 INFO - Contents: 04:21:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a9455531cec2c4b0cf83e47c79c32eb29c23b65a510adca3732d1b09591d730298e17f60d104a76be6536219fb42fe28d23a8c2bfd2900fc0500a06fb2af8b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8472ebeb73edbad53f762cf73bf1df899ae73d227dfedf5689c16c3e7b7c6d1a50c08815e59a00cf11411e17c41ebbc86ce90342cd2aca7d93b9773301596ad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40e4095d2bf6c1862acdb4e93c0ad07eb1840307c8aaa49cbb688148aeabe49abd49fb2d21c98dc2064c340541f2c6a46b86bdff0e20414dfef6c1348ae68f65", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f59a7467de4b369a3e5d91539bc08c58c805cd49e1f68e65853580073779fa31899a622452374430af2b8c2d33a29ffc6c7ac8f0045b8bf32e264617a9260a"} 04:21:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:05 INFO - Copying logs to upload dir... 04:21:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.502263 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-12 04:21:05.583095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-12 04:21:05.587955) ========= 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=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a9455531cec2c4b0cf83e47c79c32eb29c23b65a510adca3732d1b09591d730298e17f60d104a76be6536219fb42fe28d23a8c2bfd2900fc0500a06fb2af8b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8472ebeb73edbad53f762cf73bf1df899ae73d227dfedf5689c16c3e7b7c6d1a50c08815e59a00cf11411e17c41ebbc86ce90342cd2aca7d93b9773301596ad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40e4095d2bf6c1862acdb4e93c0ad07eb1840307c8aaa49cbb688148aeabe49abd49fb2d21c98dc2064c340541f2c6a46b86bdff0e20414dfef6c1348ae68f65", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f59a7467de4b369a3e5d91539bc08c58c805cd49e1f68e65853580073779fa31899a622452374430af2b8c2d33a29ffc6c7ac8f0045b8bf32e264617a9260a"} build_url:https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/dQw1nXGeRJ-it9XJgZiT1A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a9455531cec2c4b0cf83e47c79c32eb29c23b65a510adca3732d1b09591d730298e17f60d104a76be6536219fb42fe28d23a8c2bfd2900fc0500a06fb2af8b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8472ebeb73edbad53f762cf73bf1df899ae73d227dfedf5689c16c3e7b7c6d1a50c08815e59a00cf11411e17c41ebbc86ce90342cd2aca7d93b9773301596ad", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40e4095d2bf6c1862acdb4e93c0ad07eb1840307c8aaa49cbb688148aeabe49abd49fb2d21c98dc2064c340541f2c6a46b86bdff0e20414dfef6c1348ae68f65", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f59a7467de4b369a3e5d91539bc08c58c805cd49e1f68e65853580073779fa31899a622452374430af2b8c2d33a29ffc6c7ac8f0045b8bf32e264617a9260a"}' ========= master_lag: 1.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-09-12 04:21:07.079745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:21:07.080153) ========= 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=fa44defc139c4ba8574fe040000001db-1505213914.940624-878060152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:21:07.104240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 04:21:07.106579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 04:21:07.106899) ========= ========= Total master_lag: 1.75 =========