builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1503577765.05 results: success (0) revision: 32674de9af80667006ab1a4efcdc70115faf48e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.048124) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.048540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.048825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.064479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.064769) ========= 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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 05:29:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2017-08-24 05:29:25 (23.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106260 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.314663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.314998) ========= 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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016234 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:25.344659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:29:25.345020) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32674de9af80667006ab1a4efcdc70115faf48e9 --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 32674de9af80667006ab1a4efcdc70115faf48e9 --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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 05:29:25,701 truncating revision to first 12 chars 2017-08-24 05:29:25,701 Setting DEBUG logging. 2017-08-24 05:29:25,701 attempt 1/10 2017-08-24 05:29:25,701 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32674de9af80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 05:29:27,152 unpacking tar archive at: mozilla-central-32674de9af80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.772404 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:29:27.135333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:27.135660) ========= script_repo_revision: 32674de9af80667006ab1a4efcdc70115faf48e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:27.139077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:27.139357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:29:27.151812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-24 05:29:27.152089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-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-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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:27 INFO - MultiFileLogger online at 20170824 05:29:27 in /builds/slave/test 05:29:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:29:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:27 INFO - {'append_to_log': False, 05:29:27 INFO - 'base_work_dir': '/builds/slave/test', 05:29:27 INFO - 'blob_upload_branch': 'Firefox', 05:29:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:27 INFO - 'branch': 'Firefox', 05:29:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:27 INFO - 'code_coverage': False, 05:29:27 INFO - 'config_files': ('talos/linux_config.py',), 05:29:27 INFO - 'default_actions': ('clobber', 05:29:27 INFO - 'read-buildbot-config', 05:29:27 INFO - 'download-and-extract', 05:29:27 INFO - 'populate-webroot', 05:29:27 INFO - 'create-virtualenv', 05:29:27 INFO - 'install', 05:29:27 INFO - 'setup-mitmproxy', 05:29:27 INFO - 'run-tests'), 05:29:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:27 INFO - 'disable_ccov_upload': False, 05:29:27 INFO - 'download_minidump_stackwalk': True, 05:29:27 INFO - 'download_symbols': 'ondemand', 05:29:27 INFO - 'enable_stylo': False, 05:29:27 INFO - 'enable_webrender': False, 05:29:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:29:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:27 INFO - 'gecko_profile': False, 05:29:27 INFO - 'gecko_profile_interval': 0, 05:29:27 INFO - 'installer_path': 'installer.exe', 05:29:27 INFO - 'log_level': 'info', 05:29:27 INFO - 'log_name': 'talos', 05:29:27 INFO - 'log_to_console': True, 05:29:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:27 INFO - 'opt_config_files': (), 05:29:27 INFO - 'pip_index': False, 05:29:27 INFO - 'suite': 'dromaeojs-e10s', 05:29:27 INFO - 'system_bits': '32', 05:29:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:27 INFO - 'title': 'talos-linux64-ix-038', 05:29:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:27 INFO - 'use_talos_json': True, 05:29:27 INFO - 'verify': 'False', 05:29:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:27 INFO - 'work_dir': 'build'} 05:29:27 INFO - [mozharness: 2017-08-24 12:29:27.645930Z] Running clobber step. 05:29:27 INFO - Running pre-action listener: _resource_record_pre_action 05:29:27 INFO - Running main action method: clobber 05:29:27 INFO - rmtree: /builds/slave/test/build 05:29:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:29 INFO - Running post-action listener: _resource_record_post_action 05:29:29 INFO - [mozharness: 2017-08-24 12:29:29.163642Z] Finished clobber step (success) 05:29:29 INFO - [mozharness: 2017-08-24 12:29:29.163741Z] Running read-buildbot-config step. 05:29:29 INFO - Running pre-action listener: _resource_record_pre_action 05:29:29 INFO - Running main action method: read_buildbot_config 05:29:29 INFO - Using buildbot properties: 05:29:29 INFO - { 05:29:29 INFO - "project": "", 05:29:29 INFO - "product": "firefox", 05:29:29 INFO - "who": "archaeopteryx@coole-files.de", 05:29:29 INFO - "installer_path": "public/build/target.tar.bz2", 05:29:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:29:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:29:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:29:29 INFO - "stage_platform": "linux64-stylosequential", 05:29:29 INFO - "basedir": "/builds/slave/test", 05:29:29 INFO - "buildnumber": 168, 05:29:29 INFO - "platform": "ubuntu64_hw_styloseq", 05:29:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:29:29 INFO - "slavebuilddir": "test", 05:29:29 INFO - "taskId": "dB45_iZiR5GewaHu1lMpng", 05:29:29 INFO - "branch": "mozilla-central", 05:29:29 INFO - "script_repo_revision": "production", 05:29:29 INFO - "revision": "32674de9af80667006ab1a4efcdc70115faf48e9", 05:29:29 INFO - "slavename": "talos-linux64-ix-038", 05:29:29 INFO - "repo_path": "mozilla-central" 05:29:29 INFO - } 05:29:29 INFO - Finding installer, test and symbols from parent task. 05:29:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dB45_iZiR5GewaHu1lMpng'}, attempt #1 05:29:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dB45_iZiR5GewaHu1lMpng'}, attempt #1 05:29:30 INFO - Task dependencies: edDsDxIfTzGMCiv9-pbWyw 05:29:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw'}, attempt #1 05:29:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:29:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json 05:29:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip 05:29:30 INFO - Running post-action listener: _resource_record_post_action 05:29:30 INFO - [mozharness: 2017-08-24 12:29:30.794016Z] Finished read-buildbot-config step (success) 05:29:30 INFO - [mozharness: 2017-08-24 12:29:30.794234Z] Running download-and-extract step. 05:29:30 INFO - Running pre-action listener: _resource_record_pre_action 05:29:30 INFO - Running main action method: download_and_extract 05:29:30 INFO - mkdir: /builds/slave/test/build/tests 05:29:30 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')]} 05:29:30 INFO - trying https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json 05:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:29:31 INFO - Downloaded 989 bytes. 05:29:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:29:31 INFO - Using the following test package requirements: 05:29:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:29:31 INFO - u'common': [u'target.common.tests.zip'], 05:29:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:29:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:29:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:29:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:29:31 INFO - u'mozbase': [u'target.common.tests.zip'], 05:29:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:29:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:29:31 INFO - u'web-platform': [u'target.common.tests.zip', 05:29:31 INFO - u'target.web-platform.tests.tar.gz'], 05:29:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:29:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:29:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip 05:29:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:29:31 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip into memory 05:29:32 INFO - Content-Length response header: 54979689 05:29:32 INFO - Bytes received: 54979689 05:29:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:29:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip 05:29:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:29:43 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.common.tests.zip into memory 05:29:44 INFO - Content-Length response header: 54979689 05:29:44 INFO - Bytes received: 54979689 05:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip 05:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:30:02 INFO - Fetch https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.talos.tests.zip into memory 05:30:03 INFO - Content-Length response header: 14496384 05:30:03 INFO - Bytes received: 14496384 05:30:04 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')]} 05:30:04 INFO - trying https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:30:04 INFO - Downloading https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:30:05 INFO - Downloaded 61132206 bytes. 05:30:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:30:05 INFO - mkdir: /builds/slave/test/properties 05:30:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:05 INFO - Contents: 05:30:05 INFO - build_url:https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 05:30:05 INFO - Running post-action listener: _resource_record_post_action 05:30:05 INFO - Running post-action listener: find_tests_for_verification 05:30:05 INFO - Running post-action listener: set_extra_try_arguments 05:30:05 INFO - [mozharness: 2017-08-24 12:30:05.273785Z] Finished download-and-extract step (success) 05:30:05 INFO - [mozharness: 2017-08-24 12:30:05.273883Z] Running populate-webroot step. 05:30:05 INFO - Running pre-action listener: _resource_record_pre_action 05:30:05 INFO - Running main action method: populate_webroot 05:30:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:05 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:05 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:05 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'tests': ['damp', 'tps']}, 05:30:05 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['damp', 'tps']}, 05:30:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:30:05 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:30:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:30:05 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:30:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_many_windows', 05:30:05 INFO - 'sessionrestore_no_auto_restore', 05:30:05 INFO - 'tabpaint']}, 05:30:05 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['a11yr', 05:30:05 INFO - 'ts_paint', 05:30:05 INFO - 'tpaint', 05:30:05 INFO - 'sessionrestore', 05:30:05 INFO - 'sessionrestore_many_windows', 05:30:05 INFO - 'sessionrestore_no_auto_restore', 05:30:05 INFO - 'tabpaint']}, 05:30:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:30:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:30:05 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['bloom_basic_singleton']}, 05:30:05 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['bloom_basic']}, 05:30:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:05 INFO - 'tsvgr_opacity', 05:30:05 INFO - 'tart', 05:30:05 INFO - 'tscrollx', 05:30:05 INFO - 'tsvg_static']}, 05:30:05 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['tsvgx', 05:30:05 INFO - 'tsvgr_opacity', 05:30:05 INFO - 'tart', 05:30:05 INFO - 'tscrollx', 05:30:05 INFO - 'tsvg_static']}, 05:30:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:30:05 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--stylo'], 05:30:05 INFO - 'tests': ['tp5o']}, 05:30:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:05 INFO - 'talos_options': ['--mitmproxy', 05:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:05 INFO - '--firstNonBlankPaint'], 05:30:05 INFO - 'tests': ['tp6_google', 05:30:05 INFO - 'tp6_youtube', 05:30:05 INFO - 'tp6_amazon', 05:30:05 INFO - 'tp6_facebook']}, 05:30:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:05 INFO - 'talos_options': ['--stylo', 05:30:05 INFO - '--mitmproxy', 05:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:05 INFO - '--firstNonBlankPaint'], 05:30:05 INFO - 'tests': ['tp6_google', 05:30:05 INFO - 'tp6_youtube', 05:30:05 INFO - 'tp6_amazon', 05:30:05 INFO - 'tp6_facebook']}, 05:30:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:05 INFO - 'talos_options': ['--stylo', 05:30:05 INFO - '--stylo-threads=1', 05:30:05 INFO - '--mitmproxy', 05:30:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:05 INFO - '--firstNonBlankPaint'], 05:30:05 INFO - 'tests': ['tp6_google', 05:30:05 INFO - 'tp6_youtube', 05:30:05 INFO - 'tp6_amazon', 05:30:05 INFO - 'tp6_facebook']}, 05:30:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--xperf_path', 05:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:05 INFO - 'tests': ['tp5n']}, 05:30:05 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:05 INFO - 'talos_options': ['--stylo', 05:30:05 INFO - '--xperf_path', 05:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:05 INFO - 'tests': ['tp5n']}}} 05:30:05 INFO - Running post-action listener: _resource_record_post_action 05:30:05 INFO - [mozharness: 2017-08-24 12:30:05.288048Z] Finished populate-webroot step (success) 05:30:05 INFO - [mozharness: 2017-08-24 12:30:05.288138Z] Running create-virtualenv step. 05:30:05 INFO - Running pre-action listener: _resource_record_pre_action 05:30:05 INFO - Running main action method: create_virtualenv 05:30:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:30:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:30:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:30:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:06 INFO - Installing pip...............done. 05:30:06 INFO - Return code: 0 05:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:30:06 INFO - Reading from file tmpfile_stdout 05:30:06 INFO - Output received: 05:30:06 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:30:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:06 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')]} 05:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:06 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')]} 05:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:06 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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:06 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 05:30:06 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 05:30:06 INFO - Using env: {'DISPLAY': ':0', 05:30:06 INFO - 'HOME': '/home/cltbld', 05:30:06 INFO - 'LANG': 'en_US.UTF-8', 05:30:06 INFO - 'LANGUAGE': 'en_US:en', 05:30:06 INFO - 'LOGNAME': 'cltbld', 05:30:06 INFO - 'MAIL': '/var/mail/cltbld', 05:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:06 INFO - 'MOZ_NO_REMOTE': '1', 05:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:06 INFO - 'NO_EM_RESTART': '1', 05:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:06 INFO - 'PWD': '/builds/slave/test', 05:30:06 INFO - 'SHELL': '/bin/bash', 05:30:06 INFO - 'SHLVL': '1', 05:30:06 INFO - 'TERM': 'linux', 05:30:06 INFO - 'TMOUT': '86400', 05:30:06 INFO - 'USER': 'cltbld', 05:30:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:06 INFO - '_': '/tools/buildbot/bin/python'} 05:30:07 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:30:07 INFO - Downloading/unpacking pip>=1.5 05:30:07 INFO - Running setup.py egg_info for package pip 05:30:07 INFO - warning: no files found matching 'pip/cacert.pem' 05:30:07 INFO - warning: no files found matching '*.html' under directory 'docs' 05:30:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:30:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:30:07 INFO - Installing collected packages: pip 05:30:07 INFO - Found existing installation: pip 1.1 05:30:07 INFO - Uninstalling pip: 05:30:07 INFO - Successfully uninstalled pip 05:30:07 INFO - Running setup.py install for pip 05:30:07 INFO - warning: no files found matching 'pip/cacert.pem' 05:30:07 INFO - warning: no files found matching '*.html' under directory 'docs' 05:30:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:30:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:30:07 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:30:07 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:30:07 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:30:07 INFO - Successfully installed pip 05:30:07 INFO - Cleaning up... 05:30:07 INFO - Return code: 0 05:30:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:07 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')]} 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:07 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')]} 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:07 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 05:30:07 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 05:30:07 INFO - Using env: {'DISPLAY': ':0', 05:30:07 INFO - 'HOME': '/home/cltbld', 05:30:07 INFO - 'LANG': 'en_US.UTF-8', 05:30:07 INFO - 'LANGUAGE': 'en_US:en', 05:30:07 INFO - 'LOGNAME': 'cltbld', 05:30:07 INFO - 'MAIL': '/var/mail/cltbld', 05:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:07 INFO - 'MOZ_NO_REMOTE': '1', 05:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:07 INFO - 'NO_EM_RESTART': '1', 05:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:07 INFO - 'PWD': '/builds/slave/test', 05:30:07 INFO - 'SHELL': '/bin/bash', 05:30:07 INFO - 'SHLVL': '1', 05:30:07 INFO - 'TERM': 'linux', 05:30:07 INFO - 'TMOUT': '86400', 05:30:07 INFO - 'USER': 'cltbld', 05:30:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:07 INFO - '_': '/tools/buildbot/bin/python'} 05:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:07 INFO - Downloading/unpacking psutil>=3.1.1 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:08 INFO - Installing collected packages: psutil 05:30:08 INFO - Running setup.py install for psutil 05:30:08 INFO - building 'psutil._psutil_linux' extension 05:30:08 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 05:30:09 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 05:30:09 INFO - building 'psutil._psutil_posix' extension 05:30:09 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 05:30:09 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 05:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:09 INFO - Successfully installed psutil 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:09 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 05:30:09 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 05:30:09 INFO - Using env: {'DISPLAY': ':0', 05:30:09 INFO - 'HOME': '/home/cltbld', 05:30:09 INFO - 'LANG': 'en_US.UTF-8', 05:30:09 INFO - 'LANGUAGE': 'en_US:en', 05:30:09 INFO - 'LOGNAME': 'cltbld', 05:30:09 INFO - 'MAIL': '/var/mail/cltbld', 05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:09 INFO - 'MOZ_NO_REMOTE': '1', 05:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:09 INFO - 'NO_EM_RESTART': '1', 05:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:09 INFO - 'PWD': '/builds/slave/test', 05:30:09 INFO - 'SHELL': '/bin/bash', 05:30:09 INFO - 'SHLVL': '1', 05:30:09 INFO - 'TERM': 'linux', 05:30:09 INFO - 'TMOUT': '86400', 05:30:09 INFO - 'USER': 'cltbld', 05:30:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:09 INFO - '_': '/tools/buildbot/bin/python'} 05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:10 INFO - Installing collected packages: mozsystemmonitor 05:30:10 INFO - Running setup.py install for mozsystemmonitor 05:30:10 INFO - Successfully installed mozsystemmonitor 05:30:10 INFO - Cleaning up... 05:30:10 INFO - Return code: 0 05:30:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:10 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')]} 05:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:10 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')]} 05:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:10 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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:10 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 05:30:10 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 05:30:10 INFO - Using env: {'DISPLAY': ':0', 05:30:10 INFO - 'HOME': '/home/cltbld', 05:30:10 INFO - 'LANG': 'en_US.UTF-8', 05:30:10 INFO - 'LANGUAGE': 'en_US:en', 05:30:10 INFO - 'LOGNAME': 'cltbld', 05:30:10 INFO - 'MAIL': '/var/mail/cltbld', 05:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:10 INFO - 'MOZ_NO_REMOTE': '1', 05:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:10 INFO - 'NO_EM_RESTART': '1', 05:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:10 INFO - 'PWD': '/builds/slave/test', 05:30:10 INFO - 'SHELL': '/bin/bash', 05:30:10 INFO - 'SHLVL': '1', 05:30:10 INFO - 'TERM': 'linux', 05:30:10 INFO - 'TMOUT': '86400', 05:30:10 INFO - 'USER': 'cltbld', 05:30:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:10 INFO - '_': '/tools/buildbot/bin/python'} 05:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:12 INFO - warning: no files found matching '*.txt' 05:30:12 INFO - no previously-included directories found matching 'build' 05:30:12 INFO - no previously-included directories found matching 'dist' 05:30:12 INFO - no previously-included directories found matching '.git*' 05:30:12 INFO - Installing collected packages: jsonschema, functools32 05:30:12 INFO - Running setup.py install for functools32 05:30:12 INFO - warning: no files found matching '*.txt' 05:30:12 INFO - no previously-included directories found matching 'build' 05:30:12 INFO - no previously-included directories found matching 'dist' 05:30:12 INFO - no previously-included directories found matching '.git*' 05:30:12 INFO - Successfully installed jsonschema functools32 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30:12 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')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:12 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')]} 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:12 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 05:30:12 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 05:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:12 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')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:12 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')]} 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:12 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 05:30:12 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 05:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:13 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 05:30:13 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 05:30:13 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 05:30:13 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 05:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Downloading docopt-0.6.1.tar.gz 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:14 INFO - Running setup.py install for blobuploader 05:30:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:14 INFO - Running setup.py install for requests 05:30:15 INFO - Running setup.py install for docopt 05:30:15 INFO - Successfully installed blobuploader requests docopt 05:30:15 INFO - Cleaning up... 05:30:15 INFO - Return code: 0 05:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:15 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')]} 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:15 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')]} 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:15 INFO - Using env: {'DISPLAY': ':0', 05:30:15 INFO - 'HOME': '/home/cltbld', 05:30:15 INFO - 'LANG': 'en_US.UTF-8', 05:30:15 INFO - 'LANGUAGE': 'en_US:en', 05:30:15 INFO - 'LOGNAME': 'cltbld', 05:30:15 INFO - 'MAIL': '/var/mail/cltbld', 05:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:15 INFO - 'MOZ_NO_REMOTE': '1', 05:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:15 INFO - 'NO_EM_RESTART': '1', 05:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:15 INFO - 'PWD': '/builds/slave/test', 05:30:15 INFO - 'SHELL': '/bin/bash', 05:30:15 INFO - 'SHLVL': '1', 05:30:15 INFO - 'TERM': 'linux', 05:30:15 INFO - 'TMOUT': '86400', 05:30:15 INFO - 'USER': 'cltbld', 05:30:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:15 INFO - '_': '/tools/buildbot/bin/python'} 05:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:15 INFO - Running setup.py (path:/tmp/pip-Yo5IRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:15 INFO - Running setup.py (path:/tmp/pip-xHNHqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:15 INFO - Running setup.py (path:/tmp/pip-LrYZDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:15 INFO - Running setup.py (path:/tmp/pip-tBHel9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:15 INFO - Running setup.py (path:/tmp/pip-8yrFOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:15 INFO - Running setup.py (path:/tmp/pip-UmWJ5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:15 INFO - Running setup.py (path:/tmp/pip-qxqEo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:16 INFO - Running setup.py (path:/tmp/pip-MJlJXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:16 INFO - Running setup.py (path:/tmp/pip-EazpBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:16 INFO - Running setup.py (path:/tmp/pip-dgAtbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:16 INFO - Running setup.py (path:/tmp/pip-9gPq2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:16 INFO - Running setup.py (path:/tmp/pip-_ujSeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:16 INFO - Running setup.py (path:/tmp/pip-aKzTxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:16 INFO - Running setup.py (path:/tmp/pip-dtTQn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:16 INFO - Running setup.py (path:/tmp/pip-fGbruN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:16 INFO - Running setup.py (path:/tmp/pip-mBgZz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:16 INFO - Running setup.py (path:/tmp/pip-9HVhzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:16 INFO - Running setup.py install for manifestparser 05:30:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:16 INFO - Running setup.py install for mozcrash 05:30:16 INFO - Running setup.py install for mozdebug 05:30:17 INFO - Running setup.py install for mozdevice 05:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozfile 05:30:17 INFO - Running setup.py install for mozhttpd 05:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozinfo 05:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozInstall 05:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozleak 05:30:17 INFO - Running setup.py install for mozlog 05:30:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for moznetwork 05:30:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozprocess 05:30:17 INFO - Running setup.py install for mozprofile 05:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozrunner 05:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozscreenshot 05:30:18 INFO - Running setup.py install for moztest 05:30:18 INFO - Running setup.py install for mozversion 05:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:18 INFO - Cleaning up... 05:30:18 INFO - Return code: 0 05:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:18 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')]} 05:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:18 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')]} 05:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:18 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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:18 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 05:30:18 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 05:30:18 INFO - Using env: {'DISPLAY': ':0', 05:30:18 INFO - 'HOME': '/home/cltbld', 05:30:18 INFO - 'LANG': 'en_US.UTF-8', 05:30:18 INFO - 'LANGUAGE': 'en_US:en', 05:30:18 INFO - 'LOGNAME': 'cltbld', 05:30:18 INFO - 'MAIL': '/var/mail/cltbld', 05:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:18 INFO - 'MOZ_NO_REMOTE': '1', 05:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:18 INFO - 'NO_EM_RESTART': '1', 05:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:18 INFO - 'PWD': '/builds/slave/test', 05:30:18 INFO - 'SHELL': '/bin/bash', 05:30:18 INFO - 'SHLVL': '1', 05:30:18 INFO - 'TERM': 'linux', 05:30:18 INFO - 'TMOUT': '86400', 05:30:18 INFO - 'USER': 'cltbld', 05:30:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:18 INFO - '_': '/tools/buildbot/bin/python'} 05:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:18 INFO - Running setup.py (path:/tmp/pip-s4LzPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:18 INFO - Running setup.py (path:/tmp/pip-82Vemk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:18 INFO - Running setup.py (path:/tmp/pip-58vhAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:18 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)) 05:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:18 INFO - Running setup.py (path:/tmp/pip-YScRlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:19 INFO - Running setup.py (path:/tmp/pip-B8zNm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:19 INFO - Running setup.py (path:/tmp/pip-t8LKBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:19 INFO - Running setup.py (path:/tmp/pip-NXw3E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:19 INFO - Running setup.py (path:/tmp/pip-ZSJmC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:19 INFO - Running setup.py (path:/tmp/pip-a7dSxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:19 INFO - Running setup.py (path:/tmp/pip-e0QFMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:19 INFO - Running setup.py (path:/tmp/pip-GrYxn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:19 INFO - Running setup.py (path:/tmp/pip-kEIyFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:19 INFO - Running setup.py (path:/tmp/pip-MCGUsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:19 INFO - Running setup.py (path:/tmp/pip-Fcm9QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:19 INFO - Running setup.py (path:/tmp/pip-i97OAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:19 INFO - Running setup.py (path:/tmp/pip-ycGtcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:19 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)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:19 INFO - Running setup.py (path:/tmp/pip-M2UNyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:19 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)) 05:30:19 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)) 05:30:19 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)) 05:30:19 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)) 05:30:19 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)) 05:30:19 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)) 05:30:19 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)) 05:30:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:19 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 05:30:19 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 05:30:19 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 05:30:19 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 05:30:21 INFO - Downloading blessings-1.6.tar.gz 05:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:21 INFO - Installing collected packages: blessings 05:30:21 INFO - Running setup.py install for blessings 05:30:21 INFO - Successfully installed blessings 05:30:21 INFO - Cleaning up... 05:30:21 INFO - Return code: 0 05:30:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:21 INFO - Reading from file tmpfile_stdout 05:30:21 INFO - Current package versions: 05:30:21 INFO - argparse == 1.2.1 05:30:21 INFO - blessings == 1.6 05:30:21 INFO - blobuploader == 1.2.4 05:30:21 INFO - docopt == 0.6.1 05:30:21 INFO - functools32 == 3.2.3-2 05:30:21 INFO - jsonschema == 2.5.1 05:30:21 INFO - manifestparser == 1.1 05:30:21 INFO - mozInstall == 1.13 05:30:21 INFO - mozcrash == 1.0 05:30:21 INFO - mozdebug == 0.1 05:30:21 INFO - mozdevice == 0.51 05:30:21 INFO - mozfile == 1.2 05:30:21 INFO - mozhttpd == 0.7 05:30:21 INFO - mozinfo == 0.10 05:30:21 INFO - mozleak == 0.1 05:30:21 INFO - mozlog == 3.5 05:30:21 INFO - moznetwork == 0.27 05:30:21 INFO - mozprocess == 0.25 05:30:21 INFO - mozprofile == 0.28 05:30:21 INFO - mozrunner == 6.13 05:30:21 INFO - mozscreenshot == 0.1 05:30:21 INFO - mozsystemmonitor == 0.3 05:30:21 INFO - moztest == 0.8 05:30:21 INFO - mozversion == 1.4 05:30:21 INFO - psutil == 3.1.1 05:30:21 INFO - requests == 1.2.3 05:30:21 INFO - wsgiref == 0.1.2 05:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:21 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')]} 05:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:21 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')]} 05:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:21 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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:21 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 05:30:21 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 05:30:21 INFO - Using env: {'DISPLAY': ':0', 05:30:21 INFO - 'HOME': '/home/cltbld', 05:30:21 INFO - 'LANG': 'en_US.UTF-8', 05:30:21 INFO - 'LANGUAGE': 'en_US:en', 05:30:21 INFO - 'LOGNAME': 'cltbld', 05:30:21 INFO - 'MAIL': '/var/mail/cltbld', 05:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:21 INFO - 'MOZ_NO_REMOTE': '1', 05:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:21 INFO - 'NO_EM_RESTART': '1', 05:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:21 INFO - 'PWD': '/builds/slave/test', 05:30:21 INFO - 'SHELL': '/bin/bash', 05:30:21 INFO - 'SHLVL': '1', 05:30:21 INFO - 'TERM': 'linux', 05:30:21 INFO - 'TMOUT': '86400', 05:30:21 INFO - 'USER': 'cltbld', 05:30:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:21 INFO - '_': '/tools/buildbot/bin/python'} 05:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 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)) 05:30:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:30:21 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 05:30:21 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 05:30:21 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 05:30:21 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 05:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:30:22 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)) 05:30:22 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)) 05:30:22 INFO - Installing collected packages: simplejson 05:30:22 INFO - Running setup.py install for simplejson 05:30:23 INFO - building 'simplejson._speedups' extension 05:30:23 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 05:30:23 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 05:30:23 INFO - Successfully installed simplejson 05:30:23 INFO - Cleaning up... 05:30:23 INFO - Return code: 0 05:30:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30: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')]} 05:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', '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 05:30:23 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 05:30:23 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 05:30:23 INFO - Using env: {'DISPLAY': ':0', 05:30:23 INFO - 'HOME': '/home/cltbld', 05:30:23 INFO - 'LANG': 'en_US.UTF-8', 05:30:23 INFO - 'LANGUAGE': 'en_US:en', 05:30:23 INFO - 'LOGNAME': 'cltbld', 05:30:23 INFO - 'MAIL': '/var/mail/cltbld', 05:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:23 INFO - 'MOZ_NO_REMOTE': '1', 05:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:23 INFO - 'NO_EM_RESTART': '1', 05:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:23 INFO - 'PWD': '/builds/slave/test', 05:30:23 INFO - 'SHELL': '/bin/bash', 05:30:23 INFO - 'SHLVL': '1', 05:30:23 INFO - 'TERM': 'linux', 05:30:23 INFO - 'TMOUT': '86400', 05:30:23 INFO - 'USER': 'cltbld', 05:30:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:23 INFO - '_': '/tools/buildbot/bin/python'} 05:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:24 INFO - Cleaning up... 05:30:24 INFO - Return code: 0 05:30:24 INFO - Running post-action listener: _resource_record_post_action 05:30:24 INFO - Running post-action listener: _start_resource_monitoring 05:30:24 INFO - Starting resource monitoring. 05:30:24 INFO - [mozharness: 2017-08-24 12:30:24.230641Z] Finished create-virtualenv step (success) 05:30:24 INFO - [mozharness: 2017-08-24 12:30:24.231118Z] Running install step. 05:30:24 INFO - Running pre-action listener: _resource_record_pre_action 05:30:24 INFO - Running main action method: install 05:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:24 INFO - Reading from file tmpfile_stdout 05:30:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:24 INFO - Reading from file tmpfile_stdout 05:30:24 INFO - Output received: 05:30:24 INFO - Usage: mozinstall [options] installer 05:30:24 INFO - Options: 05:30:24 INFO - -h, --help show this help message and exit 05:30:24 INFO - -d DEST, --destination=DEST 05:30:24 INFO - Directory to install application into. [default: 05:30:24 INFO - "/builds/slave/test"] 05:30:24 INFO - --app=APP Application being installed. [default: firefox] 05:30:24 INFO - mkdir: /builds/slave/test/build/application 05:30:24 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'] 05:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:30:42 INFO - Reading from file tmpfile_stdout 05:30:42 INFO - Output received: 05:30:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:42 INFO - Running post-action listener: _resource_record_post_action 05:30:42 INFO - [mozharness: 2017-08-24 12:30:42.284637Z] Finished install step (success) 05:30:42 INFO - [mozharness: 2017-08-24 12:30:42.284889Z] Running setup-mitmproxy step. 05:30:42 INFO - Running pre-action listener: _resource_record_pre_action 05:30:42 INFO - Running main action method: setup_mitmproxy 05:30:42 INFO - Skipping: mitmproxy is not required 05:30:42 INFO - Running post-action listener: _resource_record_post_action 05:30:42 INFO - [mozharness: 2017-08-24 12:30:42.286064Z] Finished setup-mitmproxy step (success) 05:30:42 INFO - [mozharness: 2017-08-24 12:30:42.286285Z] Running run-tests step. 05:30:42 INFO - Running pre-action listener: _resource_record_pre_action 05:30:42 INFO - Running pre-action listener: _set_gcov_prefix 05:30:42 INFO - Running main action method: run_tests 05:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:42 INFO - Python 2.7.3 05:30:42 INFO - Return code: 0 05:30:42 INFO - grabbing minidump binary from tooltool 05:30: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')]} 05:30:42 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 0x296a130>, '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 0x296b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x296b4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:42 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 05:30:42 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 05:30:42 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 05:30:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:42 INFO - Return code: 0 05:30:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:42 INFO - ENV: RUST_BACKTRACE is now full 05:30:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:30:42 INFO - Using env: {'DISPLAY': ':0', 05:30:42 INFO - 'HOME': '/home/cltbld', 05:30:42 INFO - 'LANG': 'en_US.UTF-8', 05:30:42 INFO - 'LANGUAGE': 'en_US:en', 05:30:42 INFO - 'LOGNAME': 'cltbld', 05:30:42 INFO - 'MAIL': '/var/mail/cltbld', 05:30:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:42 INFO - 'MOZ_NO_REMOTE': '1', 05:30:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:42 INFO - 'NO_EM_RESTART': '1', 05:30:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:42 INFO - 'PWD': '/builds/slave/test', 05:30:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:42 INFO - 'RUST_BACKTRACE': 'full', 05:30:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:30:42 INFO - 'SHELL': '/bin/bash', 05:30:42 INFO - 'SHLVL': '1', 05:30:42 INFO - 'STYLO_FORCE_ENABLED': '1', 05:30:42 INFO - 'TERM': 'linux', 05:30:42 INFO - 'TMOUT': '86400', 05:30:42 INFO - 'USER': 'cltbld', 05:30:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899', 05:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:42 INFO - '_': '/tools/buildbot/bin/python'} 05:30:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:30:42 INFO - mozversion application_buildid: 20170824112915 05:30:42 INFO - mozversion application_changeset: 32674de9af80667006ab1a4efcdc70115faf48e9 05:30:42 INFO - mozversion application_display_name: Nightly 05:30:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:42 INFO - mozversion application_name: Firefox 05:30:42 INFO - mozversion application_remotingname: firefox 05:30:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:30:42 INFO - mozversion application_vendor: Mozilla 05:30:42 INFO - mozversion application_version: 57.0a1 05:30:42 INFO - mozversion platform_buildid: 20170824112915 05:30:42 INFO - mozversion platform_changeset: 32674de9af80667006ab1a4efcdc70115faf48e9 05:30:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:30:42 INFO - mozversion platform_version: 57.0a1 05:30:42 INFO - using testdate: 1503577842 05:30:42 INFO - actual date: 1503577842 05:30:42 INFO - starting webserver on 'localhost:32849' 05:30:42 INFO - SUITE-START | Running 2 tests 05:30:42 INFO - TEST-START | dromaeo_css 05:30:42 INFO - Initialising browser for dromaeo_css test... 05:30:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32849/getInfo.html -profile /tmp/tmprUEiAz/profile 05:30:42 INFO - TEST-INFO | started process 12304 (/builds/slave/test/build/application/firefox/firefox http://localhost:32849/getInfo.html) 05:30:49 INFO - TEST-INFO | 12304: exit 0 05:30:50 INFO - Browser initialized. 05:30:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:50 INFO - TEST-INFO | started process 12491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUEiAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:51 INFO - PID 12491 | 05:30:51 INFO - PID 12491 | (/builds/slave/test/build/application/firefox/firefox:12540): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:30:51 INFO - PID 12491 | 05:30:51 INFO - PID 12491 | 05:30:51 INFO - PID 12491 | (/builds/slave/test/build/application/firefox/firefox:12601): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:30:51 INFO - PID 12491 | 05:30:51 INFO - PID 12491 | __metrics Screen width/height:1600/1200 05:30:51 INFO - PID 12491 | colorDepth:24 05:30:51 INFO - PID 12491 | Browser inner width/height: 1024/768 05:30:51 INFO - PID 12491 | __metrics 05:31:01 INFO - PID 12491 | RSS: Main: 174768128 05:31:01 INFO - PID 12491 | 05:33:59 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32849/tests/dromaeo/cssquery-ext.html) 05:34:01 INFO - PID 12491 | RSS: Main: 178769920 05:34:01 INFO - PID 12491 | 05:37:03 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-ext.html (next: http://localhost:32849/tests/dromaeo/cssquery-jquery.html) 05:37:03 INFO - PID 12491 | RSS: Main: 172969984 05:37:03 INFO - PID 12491 | 05:40:05 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32849/tests/dromaeo/cssquery-mootools.html) 05:40:06 INFO - PID 12491 | RSS: Main: 177283072 05:40:06 INFO - PID 12491 | 05:43:07 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32849/tests/dromaeo/cssquery-prototype.html) 05:43:08 INFO - PID 12491 | RSS: Main: 175206400 05:43:08 INFO - PID 12491 | 05:46:12 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32849/tests/dromaeo/cssquery-yui.html) 05:46:12 INFO - PID 12491 | RSS: Main: 179269632 05:46:12 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | Cycle 1(1): loaded http://localhost:32849/tests/dromaeo/cssquery-yui.html (next: http://localhost:32849/tests/dromaeo/cssquery-dojo.html) 05:49:14 INFO - PID 12491 | RSS: Main: 179949568 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | __start_tp_report 05:49:14 INFO - PID 12491 | _x_x_mozilla_page_load 05:49:14 INFO - PID 12491 | _x_x_mozilla_page_load_details 05:49:14 INFO - PID 12491 | |i|pagename|runs| 05:49:14 INFO - PID 12491 | |0;dojo.html;3276.0335700968226;3293.7035666789984;3305.05805845334;3311.768176227665;3316.535685004099;6168.074788781685;6240.812775616733;6253.687315634223;6304;6324.462420694235;6052.8486787830325;6154;6160.4763595094355;6178.814635560941;6197.101420294055;5663.5186009189265;5682.488576028157;5683.3464151622575;5700.458456446631;5715.971420142893;5721.456461636138;5742.6841523716175;5770.19217309577;5772.653640781546;5867.383924687911;5690.516306113986;5714.742836572344;5743.971280143614;5755.223044888929;5774.624649397797;5473.507384335429;5562.054450743383;5592.245046918695;5596.58025648078;5654.349749778787;5635.408282130358;5663.603547751659;5708.315002199721;5718.771249150029;5719.19931209631;6062.636241825505;6072.939270607281;6095.786647467362;6126.203593532857;6173.567850250484;6558.573692709959;6622.2715501294815;6654.10169627099;6686.197656281229;6718.899216511756;6680.0981867448245;6688.264290927994;6769.3907548320885;6789.1174147360525;6805.183377994672;6210.223722034746;6215.81352559424;6286.025666021728;6292.874142517124;6304.810855674337;6650.900236496456;6729.629870357079;6734.0572319875255;6741.966290168616;6742.123523941857;6477.028445733178;6480.51396145291;6518.478521718251;6572.441342485942;6582.012698095324;6589.901151482732;6620.9006864897065;6626.237982632059;6654.866902662016;6675.1989761228;6532.444742196872;6534.379233972765;6534.640594767334;6585.868282634417;6623.470122390294;6562.114114594564;6601.933980660228;6658.234303055211;6664.200295964515;6681.064650948871;5251.081060814418;5292.550133238641;5303.840884773463;5307.2569840222395;5308.893822123536;4532.27483602622;4536.909261814745;4623.53764623535;4647.419072615923;4719.339292499053;5697.715114244271;5704.1443783432815;5708.771649134072;5710.200571919934;5713.114467257582;6576.605403675795;6577.934220657828;6580.736770529221;6580.901286480706;6604.603723776589;5765.221695071195;5791.449812267828;5794.681292528867;5799.2750906136735;5819.243498345188;5679.176519404663;5720.1991721159075;5737.3688894221605;5737.8565535861935;5741.770329186786;6310.05349197624;6389.936100639027;6456.967715161394;6459.031145328145;6517.185351831021;6719.361660642231;6723.529352945443;6725.798226053226;6738.59568425896;6744.966275168593;6470.126532917996;6487.675616219264;6548.214214294315;6576.046473261446;6594;6555.737770489127;6574.704138313692;6609.339066093352;6652.234992975869;6653.866922661617;6602.141721576164;6606.669666516751;6690.397864192051;6756.966215169089;6758.662066896537;6433.806985790434;6519.1199188110895;6521.869562608626;6522.478201743944;6530.053142294436;6465.0948867157695;6510.121133646897;6541.313162117909;6555.475561955128;6558.311377305315;6382.393672601095;6386;6399.424051835357;6476.287608362982;6492.513061520311;6482.060101285381;6520.413162815369;6556.442702370352;6600.570962887397;6605.735770569124;6131.785387511416;6159.81520554384;6199.783007594893;6210.254769427697;6223.004319308889 05:49:14 INFO - PID 12491 | |1;ext.html;767.3592550220566;847.2417186617977;869.7173418638944;870.1081391573638;1126.6620013995798;28674;29155.416891662153;38152.618473815324;38238.42642360367;38441.99999999996;38670;38846.22307553847;38938.610613893856;38988.61011389885;39005.609943900556;7188.101487314086;7582.924170758304;7687.461877668566;7692.846143077135;7710.306072453478;7534.284242996907;7659.885101723478;7660.578668173276;7670.271324224218;7679.616019199046;7651.081870175587;7723.073231212263;7724.922750772476;7726.497777644435;7727.343175830061;7613.162552119263;7666.846663066735;7669.923300767033;7671.194524574895;7699.576523291216;7497.250274972514;7568.735094271674;7595.506292091051;7597.962010189969;7601.80995475112;35393.29213415717;35607.4658880117;35690;35696;35708.10729731777;3440.6215316315183;3471.3577988072034;3482.7562070655063;3482.7562070655063;3489.4416893296952;30399.544006839915;30449.695503045128;30468.238294042603;30478.54282185769;30609.234769130726;4847.757612119415;5016.8996620067755;5030.346055012825;5061.468545802712;5078.238264260353;192013;192753;193181;193344;194377.16868493825;45733.314000290025;45755.31367029497;45951;45957.540424595994;45985.31022034672;47534.762326188145;47646.5235347649;47748;47749.522504774504;47795;13994;14649.121052736657;14692.779608305884;14707.41170353174;14738.631534211516;11655.009324207538;12810.67973300675;13132.474701012043;13133.080684352004;13175.538856139989;13563.186208827501;13588.728225435436;13629;13696.65758356029;13749.725005499835;5626.85932851682;5679.716014199356;5682.772689092472;5702.144678298206;5747.885042299131;1003.2726273451689;1024.3700124423574;1027.7379268286538;1031.7369070887025;1042.5204405973186;21953.121875125136;22039.33881983543;22172.445688857584;22244.555108898054;22346;1113.9665810025713;1130.8021096308114;1131.6322195286564;1138.7893239750672;1142.6343570057502;11814.232074915102;11873.990710789507;11880;11898.345590992578;11963.521459141537;217845;218451;218711;219029;219348;47887.521124789004;48141.5185848144;48165.75917120392;48213.5178648216;48334.758326208146;1418.0853349589456;1430.4063813517482;1446.2045874769046;1457.1912588513264;1469.2662658063375;21993.34019979403;22028.88985555062;22326;22327.553448931256;22474;35106.64893351034;35413.29173416465;35433.46849797307;35486.112847177996;35601.643983559836;186105;186431;186598;187454;187755;29572.408551829274;30144.09567712972;30210.395792084473;31893.362132756753;32106.03681889547;42064.57935420729;42182.36726449044;42386.788066059475;42610.78694606507;42700.14599708051;30338.84830575833;30820.38359232758;31002.68997309998;31321.216969575944;31625.20936976594;29960.700392996663;30277.848610756806;30725.692743073178;30772;30836.69163308428;34413.827930860185;34572.654273456945;34613.48079778856;34667.826660866536;34719.65280347164;29889.850550747105;30101.397972040875;30206.54690179693;30229.244268893453;30411.69588304177;22723.659145113168;22810.20164294242;22944.655830162228;23027.88486057626;24242.51514969726 05:49:14 INFO - PID 12491 | |2;jquery.html;543.3452689509141;548.5173047718008;550.6971165858777;564.1312378936436;582.9067349224124;21701.565968680636;22398.88800555999;22465.887670561624;22481.66277505837;22498.10007599696;24800;25151.74848251517;25269.873650631765;25345.239642810746;25347.87326063367;6513.446357059655;6656.13470248867;6661.16735408074;6664.366885145928;6670.533062685614;5888.116782482641;6441.742330306782;6538.6076835389795;6633.071370008202;6645.269020407775;6365.968170159166;6400.9039864402075;6403.263624683151;6404.391582799627;6404.455621272197;6366.968165159191;6381.744730210786;6388.55280130391;6402.583832050902;6422.389872962061;5896.439838215363;5927.4665280125;5958.6424814511265;5979.880402391927;5980.401959803985;27966.44067118646;28513.714862851313;28992;29098.272543186376;29480.26299342512;2007.3576455534235;2036.1855257896812;2047.1606641277153;2048.805363490466;2057.2593866208153;18960.43118706441;19341.51646208842;19370.806291937042;19920.203191872308;20910;2482.491089326684;2512.459821138446;2543.9872800636062;2617.0578591707163;2619;134706;136485;137167;139984;140006.29996850053;20520.301968993732;20685.896570517052;20788.480287992923;21276.468088297916;21885.890570547046;42693.57306426958;42763.14473710571;42830.357544636856;42848.14303713908;42863;10530.473476326153;10835.67492975212;10850.511726972305;10922.726931826768;10990.395528246023;8863.867041994376;8894.110588941054;8897.466152030898;8924.55377231136;9034.32242581809;8874.733757987271;9249.260059195249;9258.166764991049;11114;11473.713157171138;2626.75045870642;2644.180304105695;2672.0914888937855;2706.4316493536576;2753.752162305402;916.1205242966694;966.4732720667254;969.8642190093393;970.1656575345197;970.4613939263777;19336.8066319335;19552.120154593078;19632.70550941737;19716.309929152412;19816.504587385432;1000.8148492528906;1018.6536577563664;1019.4342140112161;1022.544967489475;1027.4605831938143;11031.393273370042;11033.337999720043;11126.332420054661;11208.887911120948;11470.655880323604;457255;460190;460631;474001;477381;113194;119625;121931.39034304772;123270;124877;1176.670532250971;1201.1891972918245;1221.3587866370226;1227.3311045480234;1227.5948936850818;20096.971750624532;20406.28577999763;20415.489612759207;20530;20964.895175524023;58210.126848096465;60123.69938150281;60178;60430.697846510484;61590.384096158465;74354;75173.62413187898;75222.24777752372;75652;76028.61985690036;11406.885931140914;14207.64480887986;14273.57179284623;14418.639534011734;14429.7835532465;22454.32637020892;22538.09847606143;22613;22735;22968.655470167625;17092.145392730563;17148.74276885823;17261.39585114515;17401.21694523775;17401.47795566135;16269.349226030827;16679.416220432227;16956.91521542434;17084.572885677957;17181.57046073858;17736.467905962843;18366.173522191802;18507.629847403245;18520.2591896328;18556.536086597403;13991.16053036821;13994.16035037901;14092.577222683336;14142.575722728334;14245.074070185405;17115.828841711424;17304.394346198325;17534.73697894558;17936.641267174324;17944.91027544854 05:49:14 INFO - PID 12491 | |3;mootools.html;1272.5291642092427;1330.9866901330986;1333.4932725564283;1340.7653660609385;1344.8251727275454;14429.927850360747;14926.776098358507;14974.401023959043;14978.251087445626;15182.392704291815;15148.394064237416;15339.079655220667;15379.769303460429;15404.460843870467;15413.152276624809;2684.7181045990183;2690.8520031398266;2736.7400096990755;2740.1368568900734;2740.3149212696826;2630.4344565918323;2647.761701446869;2652.0717748787865;2657.0434643528315;2661.5874539446418;2745.1901689001693;2770.570561562951;2771.9029833955815;2772.6118343431936;2773.764230040449;2642.431877146413;2661.3213630524288;2670.012095524649;2671.011725661498;2671.131882138303;2595.1954893982925;2598.7396112885235;2619.1095027690485;2629.382095207625;2630;14530.854691453056;14671;14679.77980330296;14688.265586720621;14704.191269480174;7686.807829804244;7923.524588524707;7936.325412339958;7946.2848343648775;7953.801154971115;5371.865703357408;5472.452754724535;5528.308961379827;5591.161325801122;5604.1593760935775;1833.51411875853;1868.4768264885854;1874.7562816833724;1906.5614908570967;1908.2557802457052;24932.50134997308;24987.500249994897;25166.748332516625;25199;25671.101511447196;6605.867882642417;6680.899786503206;6703.229128650268;6832.214295355998;6867.038614593961;16724.74912876308;16729.916350418414;16750.16249187536;16750.329986800392;16754.329826807036;7604.315611594983;7676.462647614613;7707.190744971697;7709.2290770922455;7709.653065612061;7069.752558660422;7150.213476517579;7178;7200.387967022757;7264.091988501437;4946.629002824802;5039.748012599355;5068.873278168076;5089.465606111305;5105.897882042413;1502.4891536877515;1513.3038802151134;1518.142249628956;1531.2037740375165;1550.759632257002;868.1492137705085;904.421170450912;904.6562306323686;911.4303560274828;922.2990527199377;7520.811979700442;7562.168161502231;7633.1985141559335;7642.923570764332;7708.807279818049;697.8394969157021;704.5244459989486;708.373089815517;712.6971037309227;716.5593160206436;5098.133317336062;5521.779128834882;5558.333000040021;5685.658860468385;5769.798057067983;20741.170353185702;21609.67585486219;21624.56750864974;21632.783672163077;21798.237061702763;19883.502912427015;21016.78983210179;21047.473813154793;21085.367438976857;21253.149874005176;9844.655437059668;10091.394516329045;10689.412082335546;10937.234393592373;10985.340879547093;8449.324054075536;8486.660533578835;8567.657293708431;8676.392652514263;8691.652333906573;17782;17860.106994650476;17874.821251787835;18143.727844082612;18235.908820455814;18367.908160459112;18547.536311592317;18586.535336616693;18825.811741882953;18989.71515427242;11589.420528973686;11787;11809.822852657046;11816.291022538675;11835.28988260707;13447.731045379232;13615.52345667897;13671.453141874214;13759.17444953306;13817.585472435843;11148;11226.270292430965;11450.484728187084;11586.536538538365;11648;11042.17183711241;11103.944480277547;11152.888471115184;11419.200655954004;11511.424428778695;9781.41311521311;9908.603655853685;10003.34978226413;10137.797244055226;10138.442385668564;6989.0995236978115;7017.824554386181;7116.9644151780985;7119.288071193047;7125.216226215009;6986.895196571953;7047.577145371294;7079.929200707927;7114.50198486101;7151.42788576923 05:49:14 INFO - PID 12491 | |4;prototype.html;496.3200415430859;500.4370083655887;502.49071116930565;524.6065450911816;530.5278302310944;6294.653794041325;6311.62130272184;6339.366063393658;6340.270868850078;6354.3963323484195;6191.690415479231;6223.8755224895585;6258.718357673904;6269.373062693729;6282.277538083122;5142.614303927211;5142.948570514284;5154.381474223099;5215.921761173586;5217.869553261161;4776.641751868607;5147.433782283946;5171.3535808024;5171.5862730981435;5193.402758682743;4867.513248675122;4881.145799485093;4891.755412229392;4938.950610493885;4978.6514943953935;4855.053264613402;4874.3419638348905;4923.236898280772;4941.579965702919;4948.7278199699;4376.190404775127;4404.207242696345;4407.294832826765;4417;4454.153710794971;6032.276126864805;6051.152838602599;6060.878782424327;6061.909071363933;6141.877162456771;5631.845471678296;5645.745941432645;5668.858278543028;5684.857878553028;5727.369989301215;6376.3623637635865;6377.394147555975;6386.265579458375;6466.224053113657;6508.93491065088;4798.376211092535;4801.303810947393;4806.375171227753;4821.252705830567;4838.056578967103;6512.967435162794;6631.834204144935;6669.732291021028;6818.147731533559;6888.655567221619;4880.511948805091;4893.902121957541;4922.138625740481;4977.129002424561;4981.950180498221;4941.492844682406;4977.32806071183;5004.42449118356;5020.196768517019;5039.118154322979;5546.972265138729;5575.832725018256;5591.776328946878;5621.971890140523;5707.686077265707;6622.933770662232;6631.137952066297;6650.634215118215;6669.133012708414;6670.866582668319;1742.416290542657;1744.9302027918995;1760.64787042592;1760.8730412535988;1765.2762367429293;1164.7495788405533;1185.3480585677842;1211.0562547111936;1216.3492531495608;1224.8468941382328;5785.334686511105;5785.942140578624;5792.507636850831;5792.594518383673;5837.270341207349;6721.798346049529;6723.193216813916;6725.730970761213;6753.898691519631;6786.219584747719;5685.857853553694;5697.116946873241;5708.286464191976;5781.19063331134;5797.9420205797405;3532.7880327179937;3538.4161613333513;3570.214552798432;3578.8747393841613;3581.068922080278;6528.151340325728;6580.309067547934;6589.374009469093;6592.736290548421;6592.80221593353;6671.532992690562;6804.421624161902;6867.690953907087;6911.75808846688;6966.164060312795;6120.510359171167;6370.833916468423;6455.677216139175;6487.643179625072;6565.310642382577;6713.697883595152;6727.596344219362;6747.797566073025;6747.831304217434;6752.189737231563;6470.514711396759;6620.5834870272965;6679.76620818269;6694.129763130762;6696;6429.22849258092;6554.14796076507;6557.737690492327;6565.868682626417;6626.734930602915;4946.233333833262;4989.525995030466;4994.300797888372;5018.42288136869;5018.899622007612;6455.935440645533;6614.702338394687;6623.138991931018;6711.530192886647;6771.424428923597;6161.507079433545;6392.488600911823;6411.51913606472;6418.775342862978;6472.449841763503;6394.424501794861;6411.4870810336;6487.935120648733;6540.967295163494;6558.278589355072;6426;6433.195850518685;6466.4503517201565;6485.221773387224;6508.414242718178;6448.645324507197;6479.514036447191;6543.5419520635005;6586.80239592813;6589;6263.248410190807;6320.936790632219;6329.240491141092;6392.296847346881;6440.871182576228 05:49:14 INFO - PID 12491 | |5;yui.html;871.8212766382892;896.211334026057;897.1199561894806;907.5235501361789;912.2610685344869;17587.1206439678;18338.724919126205;18628.25486980519;18712.719309210355;21043.68434473484;17831;18068.186931588076;18250.361237356694;18421.078946052676;18429.17068731907;957.9664711735073;972.1299437003877;975.1321324021626;975.2831668723483;975.5073687787657;930.9813803723921;967.1778987860298;967.4388854464429;970.9854352184723;972.5623469438746;1006.4464544500532;1014.4775440648073;1017.7811770469348;1020.9234307426973;1021.0657248617506;992.9751756206152;1003.4079892863173;1004.5931397783909;1004.8141093897652;1006.8036732837099;728.3772374619676;732.1726449112468;738.5568658804727;739.6930273936364;740.4668638580214;16957.15214239283;17422.912885435493;17628.735568966476;17654.646907061786;18186;20683.793162068338;20782;21181.470463238544;21270.787292127035;21289.36131916045;16880.83119168805;16991.915040424843;17021.234044467903;17023.914880425644;17480.825191748176;3773.8679146230024;3787.6401741834484;3792.469054332396;3794.772313661189;3795.9810200949096;127421;128091;129639;132965;134225;16006.199690015686;16166.83833161677;16547.338106475847;16628.33486660544;16650.83349166517;26708.46583068328;26768;27225.45549089007;27376.45247095047;29964.70035299619;8766.649334026695;8812.206901378906;8822.955885220534;8838.823223535494;8868.33487488428;3837.1558257183374;4068.145689405199;4264.104538046983;4320.956790432056;4322.913541729211;5079.3650793650795;5145.562627176732;5176.327077479904;5177.404598471148;5177.58579313654;998.3610489286863;1007.1942446043137;1030.2427715629008;1037.896210378956;1038.5949479702922;679.1103654212997;701.5229643842134;711.6726305899241;716.9459498536655;717.3292971072065;10935.070519005814;11425.114856048658;11636.825447618292;12194.39028048594;12588.685282867818;635.3043417457876;650.854496086881;651.3746803069012;654.6726636681659;663.7776344924505;5625.803096891589;5721.713914304268;5724.198612194296;5853.473187413153;6526.184226971629;106690.46654766676;110791.44604277088;111111;111823.44088279507;113357;92399;93930;96910;98991;99219.53512091973;83986;86512;86698.56650716832;88142.11857881467;88785;11488.942555287504;11959.940200298943;12117;12148.939255303667;12658.11393202467;38100.61899380971;39206.21587568176;39888;41417.58582414137;41999.370009449274;50579;52177;52675.47324526706;54366;70697.29302707112;18166.09169541491;18916.33792817245;18987.715184271972;19097.618047639247;19245.80754192496;21362.252321168686;21435.46411339729;21443.035063422496;21489.14043438245;21500.354989350344;17937.461876143738;18832.24671013144;18921.053947302855;19455;19670;19119.330823421114;19184.90407547953;19233.90383048076;19250.903745481184;19769.308074217333;16688.916555417145;16760.58098547546;16763.664726705643;17380.39168629092;17831.821681783014;12436.813447798471;12547.623571292876;12630.747385052064;12726.68183295425;13187.340632968506;13245.337733113498;13249.735005299648;13379.397927093109;13383;13390.062695611214 05:49:14 INFO - PID 12491 | __end_tp_report 05:49:14 INFO - PID 12491 | __start_cc_report 05:49:14 INFO - PID 12491 | _x_x_mozilla_cycle_collect,385 05:49:14 INFO - PID 12491 | __end_cc_report 05:49:14 INFO - PID 12491 | __startTimestamp1503578954905__endTimestamp 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | ------- Summary: start ------- 05:49:14 INFO - PID 12491 | Number of tests: 6 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#0] dojo.html Cycles:165 Average:6118.29 Median:6386.00 stddev:705.04 (11.0%) stddev-sans-first:671.02 05:49:14 INFO - PID 12491 | Values: 3276.0 3293.7 3305.1 3311.8 3316.5 6168.1 6240.8 6253.7 6304.0 6324.5 6052.8 6154.0 6160.5 6178.8 6197.1 5663.5 5682.5 5683.3 5700.5 5716.0 5721.5 5742.7 5770.2 5772.7 5867.4 5690.5 5714.7 5744.0 5755.2 5774.6 5473.5 5562.1 5592.2 5596.6 5654.3 5635.4 5663.6 5708.3 5718.8 5719.2 6062.6 6072.9 6095.8 6126.2 6173.6 6558.6 6622.3 6654.1 6686.2 6718.9 6680.1 6688.3 6769.4 6789.1 6805.2 6210.2 6215.8 6286.0 6292.9 6304.8 6650.9 6729.6 6734.1 6742.0 6742.1 6477.0 6480.5 6518.5 6572.4 6582.0 6589.9 6620.9 6626.2 6654.9 6675.2 6532.4 6534.4 6534.6 6585.9 6623.5 6562.1 6601.9 6658.2 6664.2 6681.1 5251.1 5292.6 5303.8 5307.3 5308.9 4532.3 4536.9 4623.5 4647.4 4719.3 5697.7 5704.1 5708.8 5710.2 5713.1 6576.6 6577.9 6580.7 6580.9 6604.6 5765.2 5791.4 5794.7 5799.3 5819.2 5679.2 5720.2 5737.4 5737.9 5741.8 6310.1 6389.9 6457.0 6459.0 6517.2 6719.4 6723.5 6725.8 6738.6 6745.0 6470.1 6487.7 6548.2 6576.0 6594.0 6555.7 6574.7 6609.3 6652.2 6653.9 6602.1 6606.7 6690.4 6757.0 6758.7 6433.8 6519.1 6521.9 6522.5 6530.1 6465.1 6510.1 6541.3 6555.5 6558.3 6382.4 6386.0 6399.4 6476.3 6492.5 6482.1 6520.4 6556.4 6600.6 6605.7 6131.8 6159.8 6199.8 6210.3 6223.0 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#1] ext.html Cycles:180 Average:35889.77 Median:31759.29 stddev:51752.20 (163.0%) stddev-sans-first:51830.18 05:49:14 INFO - PID 12491 | Values: 767.4 847.2 869.7 870.1 1126.7 28674.0 29155.4 38152.6 38238.4 38442.0 38670.0 38846.2 38938.6 38988.6 39005.6 7188.1 7582.9 7687.5 7692.8 7710.3 7534.3 7659.9 7660.6 7670.3 7679.6 7651.1 7723.1 7724.9 7726.5 7727.3 7613.2 7666.8 7669.9 7671.2 7699.6 7497.3 7568.7 7595.5 7598.0 7601.8 35393.3 35607.5 35690.0 35696.0 35708.1 3440.6 3471.4 3482.8 3482.8 3489.4 30399.5 30449.7 30468.2 30478.5 30609.2 4847.8 5016.9 5030.3 5061.5 5078.2 192013.0 192753.0 193181.0 193344.0 194377.2 45733.3 45755.3 45951.0 45957.5 45985.3 47534.8 47646.5 47748.0 47749.5 47795.0 13994.0 14649.1 14692.8 14707.4 14738.6 11655.0 12810.7 13132.5 13133.1 13175.5 13563.2 13588.7 13629.0 13696.7 13749.7 5626.9 5679.7 5682.8 5702.1 5747.9 1003.3 1024.4 1027.7 1031.7 1042.5 21953.1 22039.3 22172.4 22244.6 22346.0 1114.0 1130.8 1131.6 1138.8 1142.6 11814.2 11874.0 11880.0 11898.3 11963.5 217845.0 218451.0 218711.0 219029.0 219348.0 47887.5 48141.5 48165.8 48213.5 48334.8 1418.1 1430.4 1446.2 1457.2 1469.3 21993.3 22028.9 22326.0 22327.6 22474.0 35106.6 35413.3 35433.5 35486.1 35601.6 186105.0 186431.0 186598.0 187454.0 187755.0 29572.4 30144.1 30210.4 31893.4 32106.0 42064.6 42182.4 42386.8 42610.8 42700.1 30338.8 30820.4 31002.7 31321.2 31625.2 29960.7 30277.8 30725.7 30772.0 30836.7 34413.8 34572.7 34613.5 34667.8 34719.7 29889.9 30101.4 30206.5 30229.2 30411.7 22723.7 22810.2 22944.7 23027.9 24242.5 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#2] jquery.html Cycles:180 Average:35102.77 Median:22473.78 stddev:79059.27 (351.8%) stddev-sans-first:79238.47 05:49:14 INFO - PID 12491 | Values: 543.3 548.5 550.7 564.1 582.9 21701.6 22398.9 22465.9 22481.7 22498.1 24800.0 25151.7 25269.9 25345.2 25347.9 6513.4 6656.1 6661.2 6664.4 6670.5 5888.1 6441.7 6538.6 6633.1 6645.3 6366.0 6400.9 6403.3 6404.4 6404.5 6367.0 6381.7 6388.6 6402.6 6422.4 5896.4 5927.5 5958.6 5979.9 5980.4 27966.4 28513.7 28992.0 29098.3 29480.3 2007.4 2036.2 2047.2 2048.8 2057.3 18960.4 19341.5 19370.8 19920.2 20910.0 2482.5 2512.5 2544.0 2617.1 2619.0 134706.0 136485.0 137167.0 139984.0 140006.3 20520.3 20685.9 20788.5 21276.5 21885.9 42693.6 42763.1 42830.4 42848.1 42863.0 10530.5 10835.7 10850.5 10922.7 10990.4 8863.9 8894.1 8897.5 8924.6 9034.3 8874.7 9249.3 9258.2 11114.0 11473.7 2626.8 2644.2 2672.1 2706.4 2753.8 916.1 966.5 969.9 970.2 970.5 19336.8 19552.1 19632.7 19716.3 19816.5 1000.8 1018.7 1019.4 1022.5 1027.5 11031.4 11033.3 11126.3 11208.9 11470.7 457255.0 460190.0 460631.0 474001.0 477381.0 113194.0 119625.0 121931.4 123270.0 124877.0 1176.7 1201.2 1221.4 1227.3 1227.6 20097.0 20406.3 20415.5 20530.0 20964.9 58210.1 60123.7 60178.0 60430.7 61590.4 74354.0 75173.6 75222.2 75652.0 76028.6 11406.9 14207.6 14273.6 14418.6 14429.8 22454.3 22538.1 22613.0 22735.0 22968.7 17092.1 17148.7 17261.4 17401.2 17401.5 16269.3 16679.4 16956.9 17084.6 17181.6 17736.5 18366.2 18507.6 18520.3 18556.5 13991.2 13994.2 14092.6 14142.6 14245.1 17115.8 17304.4 17534.7 17936.6 17944.9 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#3] mootools.html Cycles:180 Average:9168.17 Median:2629.69 stddev:6479.80 (246.4%) stddev-sans-first:6470.82 05:49:14 INFO - PID 12491 | Values: 1272.5 1331.0 1333.5 1340.8 1344.8 14429.9 14926.8 14974.4 14978.3 15182.4 15148.4 15339.1 15379.8 15404.5 15413.2 2684.7 2690.9 2736.7 2740.1 2740.3 2630.4 2647.8 2652.1 2657.0 2661.6 2745.2 2770.6 2771.9 2772.6 2773.8 2642.4 2661.3 2670.0 2671.0 2671.1 2595.2 2598.7 2619.1 2629.4 2630.0 14530.9 14671.0 14679.8 14688.3 14704.2 7686.8 7923.5 7936.3 7946.3 7953.8 5371.9 5472.5 5528.3 5591.2 5604.2 1833.5 1868.5 1874.8 1906.6 1908.3 24932.5 24987.5 25166.7 25199.0 25671.1 6605.9 6680.9 6703.2 6832.2 6867.0 16724.7 16729.9 16750.2 16750.3 16754.3 7604.3 7676.5 7707.2 7709.2 7709.7 7069.8 7150.2 7178.0 7200.4 7264.1 4946.6 5039.7 5068.9 5089.5 5105.9 1502.5 1513.3 1518.1 1531.2 1550.8 868.1 904.4 904.7 911.4 922.3 7520.8 7562.2 7633.2 7642.9 7708.8 697.8 704.5 708.4 712.7 716.6 5098.1 5521.8 5558.3 5685.7 5769.8 20741.2 21609.7 21624.6 21632.8 21798.2 19883.5 21016.8 21047.5 21085.4 21253.1 9844.7 10091.4 10689.4 10937.2 10985.3 8449.3 8486.7 8567.7 8676.4 8691.7 17782.0 17860.1 17874.8 18143.7 18235.9 18367.9 18547.5 18586.5 18825.8 18989.7 11589.4 11787.0 11809.8 11816.3 11835.3 13447.7 13615.5 13671.5 13759.2 13817.6 11148.0 11226.3 11450.5 11586.5 11648.0 11042.2 11103.9 11152.9 11419.2 11511.4 9781.4 9908.6 10003.3 10137.8 10138.4 6989.1 7017.8 7117.0 7119.3 7125.2 6986.9 7047.6 7079.9 7114.5 7151.4 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#4] prototype.html Cycles:180 Average:5494.44 Median:6151.69 stddev:1541.69 (25.1%) stddev-sans-first:1499.68 05:49:14 INFO - PID 12491 | Values: 496.3 500.4 502.5 524.6 530.5 6294.7 6311.6 6339.4 6340.3 6354.4 6191.7 6223.9 6258.7 6269.4 6282.3 5142.6 5142.9 5154.4 5215.9 5217.9 4776.6 5147.4 5171.4 5171.6 5193.4 4867.5 4881.1 4891.8 4939.0 4978.7 4855.1 4874.3 4923.2 4941.6 4948.7 4376.2 4404.2 4407.3 4417.0 4454.2 6032.3 6051.2 6060.9 6061.9 6141.9 5631.8 5645.7 5668.9 5684.9 5727.4 6376.4 6377.4 6386.3 6466.2 6508.9 4798.4 4801.3 4806.4 4821.3 4838.1 6513.0 6631.8 6669.7 6818.1 6888.7 4880.5 4893.9 4922.1 4977.1 4982.0 4941.5 4977.3 5004.4 5020.2 5039.1 5547.0 5575.8 5591.8 5622.0 5707.7 6622.9 6631.1 6650.6 6669.1 6670.9 1742.4 1744.9 1760.6 1760.9 1765.3 1164.7 1185.3 1211.1 1216.3 1224.8 5785.3 5785.9 5792.5 5792.6 5837.3 6721.8 6723.2 6725.7 6753.9 6786.2 5685.9 5697.1 5708.3 5781.2 5797.9 3532.8 3538.4 3570.2 3578.9 3581.1 6528.2 6580.3 6589.4 6592.7 6592.8 6671.5 6804.4 6867.7 6911.8 6966.2 6120.5 6370.8 6455.7 6487.6 6565.3 6713.7 6727.6 6747.8 6747.8 6752.2 6470.5 6620.6 6679.8 6694.1 6696.0 6429.2 6554.1 6557.7 6565.9 6626.7 4946.2 4989.5 4994.3 5018.4 5018.9 6455.9 6614.7 6623.1 6711.5 6771.4 6161.5 6392.5 6411.5 6418.8 6472.4 6394.4 6411.5 6487.9 6541.0 6558.3 6426.0 6433.2 6466.5 6485.2 6508.4 6448.6 6479.5 6543.5 6586.8 6589.0 6263.2 6320.9 6329.2 6392.3 6440.9 05:49:14 INFO - PID 12491 | 05:49:14 INFO - PID 12491 | [#5] yui.html Cycles:180 Average:23295.93 Median:21226.13 stddev:32063.81 (151.1%) stddev-sans-first:32109.55 05:49:14 INFO - PID 12491 | Values: 871.8 896.2 897.1 907.5 912.3 17587.1 18338.7 18628.3 18712.7 21043.7 17831.0 18068.2 18250.4 18421.1 18429.2 958.0 972.1 975.1 975.3 975.5 931.0 967.2 967.4 971.0 972.6 1006.4 1014.5 1017.8 1020.9 1021.1 993.0 1003.4 1004.6 1004.8 1006.8 728.4 732.2 738.6 739.7 740.5 16957.2 17422.9 17628.7 17654.6 18186.0 20683.8 20782.0 21181.5 21270.8 21289.4 16880.8 16991.9 17021.2 17023.9 17480.8 3773.9 3787.6 3792.5 3794.8 3796.0 127421.0 128091.0 129639.0 132965.0 134225.0 16006.2 16166.8 16547.3 16628.3 16650.8 26708.5 26768.0 27225.5 27376.5 29964.7 8766.6 8812.2 8823.0 8838.8 8868.3 3837.2 4068.1 4264.1 4321.0 4322.9 5079.4 5145.6 5176.3 5177.4 5177.6 998.4 1007.2 1030.2 1037.9 1038.6 679.1 701.5 711.7 716.9 717.3 10935.1 11425.1 11636.8 12194.4 12588.7 635.3 650.9 651.4 654.7 663.8 5625.8 5721.7 5724.2 5853.5 6526.2 106690.5 110791.4 111111.0 111823.4 113357.0 92399.0 93930.0 96910.0 98991.0 99219.5 83986.0 86512.0 86698.6 88142.1 88785.0 11488.9 11959.9 12117.0 12148.9 12658.1 38100.6 39206.2 39888.0 41417.6 41999.4 50579.0 52177.0 52675.5 54366.0 70697.3 18166.1 18916.3 18987.7 19097.6 19245.8 21362.3 21435.5 21443.0 21489.1 21500.4 17937.5 18832.2 18921.1 19455.0 19670.0 19119.3 19184.9 19233.9 19250.9 19769.3 16688.9 16760.6 16763.7 17380.4 17831.8 12436.8 12547.6 12630.7 12726.7 13187.3 13245.3 13249.7 13379.4 13383.0 13390.1 05:49:14 INFO - PID 12491 | -------- Summary: end -------- 05:49:14 INFO - PID 12491 | 05:49:15 INFO - TEST-INFO | 12491: exit 0 05:49:15 INFO - TEST-OK | dromaeo_css | took 1113025ms 05:49:15 INFO - TEST-START | kraken 05:49:15 INFO - Initialising browser for kraken test... 05:49:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32849/getInfo.html -profile /tmp/tmp_iaXjk/profile 05:49:15 INFO - TEST-INFO | started process 12909 (/builds/slave/test/build/application/firefox/firefox http://localhost:32849/getInfo.html) 05:49:21 INFO - TEST-INFO | 12909: exit 0 05:49:21 INFO - Browser initialized. 05:49:21 INFO - Running cycle 1/1 for kraken test... 05:49:21 INFO - TEST-INFO | started process 13096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iaXjk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:22 INFO - PID 13096 | 05:49:22 INFO - PID 13096 | (/builds/slave/test/build/application/firefox/firefox:13146): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:49:22 INFO - PID 13096 | 05:49:23 INFO - PID 13096 | 05:49:23 INFO - PID 13096 | (/builds/slave/test/build/application/firefox/firefox:13208): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:49:23 INFO - PID 13096 | 05:49:23 INFO - PID 13096 | __metrics Screen width/height:1600/1200 05:49:23 INFO - PID 13096 | colorDepth:24 05:49:23 INFO - PID 13096 | Browser inner width/height: 1024/768 05:49:23 INFO - PID 13096 | __metrics 05:49:33 INFO - PID 13096 | RSS: Main: 174686208 05:49:33 INFO - PID 13096 | 05:49:35 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:36 INFO - PID 13096 | RSS: Main: 178806784 05:49:36 INFO - PID 13096 | 05:49:39 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-dft) 05:49:39 INFO - PID 13096 | RSS: Main: 181059584 05:49:39 INFO - PID 13096 | 05:49:43 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-fft) 05:49:43 INFO - PID 13096 | RSS: Main: 174981120 05:49:43 INFO - PID 13096 | 05:49:45 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32849/tests/kraken/driver.html?testName=audio-oscillator) 05:49:46 INFO - PID 13096 | RSS: Main: 175452160 05:49:46 INFO - PID 13096 | 05:49:48 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:49 INFO - PID 13096 | RSS: Main: 175710208 05:49:49 INFO - PID 13096 | 05:49:52 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:53 INFO - PID 13096 | RSS: Main: 176762880 05:49:53 INFO - PID 13096 | 05:49:56 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32849/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:57 INFO - PID 13096 | RSS: Main: 176742400 05:49:57 INFO - PID 13096 | 05:50:00 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32849/tests/kraken/driver.html?testName=json-parse-financial) 05:50:00 INFO - PID 13096 | RSS: Main: 177373184 05:50:00 INFO - PID 13096 | 05:50:02 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:03 INFO - PID 13096 | RSS: Main: 177217536 05:50:03 INFO - PID 13096 | 05:50:04 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:05 INFO - PID 13096 | RSS: Main: 177131520 05:50:05 INFO - PID 13096 | 05:50:07 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:08 INFO - PID 13096 | RSS: Main: 176885760 05:50:08 INFO - PID 13096 | 05:50:11 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:11 INFO - PID 13096 | RSS: Main: 177070080 05:50:11 INFO - PID 13096 | 05:50:14 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:15 INFO - PID 13096 | RSS: Main: 177647616 05:50:15 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | Cycle 1(1): loaded http://localhost:32849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32849/tests/kraken/driver.html?testName=ai-astar) 05:50:17 INFO - PID 13096 | RSS: Main: 178618368 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | __start_tp_report 05:50:17 INFO - PID 13096 | _x_x_mozilla_page_load 05:50:17 INFO - PID 13096 | _x_x_mozilla_page_load_details 05:50:17 INFO - PID 13096 | |i|pagename|runs| 05:50:17 INFO - PID 13096 | |0;ai-astar;97;109;99;106;107;108;107;98;106;108 05:50:17 INFO - PID 13096 | |1;audio-beat-detection;152;122;150;172;117;144;145;119;170;118 05:50:17 INFO - PID 13096 | |2;audio-dft;162;161;161;160;163;162;164;169;166;162 05:50:17 INFO - PID 13096 | |3;audio-fft;73;74;73;169;74;77;74;72;147;74 05:50:17 INFO - PID 13096 | |4;audio-oscillator;78;78;129;79;84;83;128;79;80;129 05:50:17 INFO - PID 13096 | |5;imaging-gaussian-blur;119;115;114;114;114;114;113;114;114;116 05:50:17 INFO - PID 13096 | |6;imaging-darkroom;148;147;148;148;148;148;154;148;147;148 05:50:17 INFO - PID 13096 | |7;imaging-desaturate;94;96;94;93;94;94;94;98;94;94 05:50:17 INFO - PID 13096 | |8;json-parse-financial;53;52;54;57;52;58;53;53;58;59 05:50:17 INFO - PID 13096 | |9;json-stringify-tinderbox;55;56;54;54;55;56;55;55;58;56 05:50:17 INFO - PID 13096 | |10;stanford-crypto-aes;85;76;82;75;78;88;75;77;76;74 05:50:17 INFO - PID 13096 | |11;stanford-crypto-ccm;126;118;131;115;126;125;120;120;116;165 05:50:17 INFO - PID 13096 | |12;stanford-crypto-pbkdf2;177;172;171;186;188;172;170;170;179;169 05:50:17 INFO - PID 13096 | |13;stanford-crypto-sha256-iterative;65;65;65;68;63;64;67;66;68;64 05:50:17 INFO - PID 13096 | __end_tp_report 05:50:17 INFO - PID 13096 | __start_cc_report 05:50:17 INFO - PID 13096 | _x_x_mozilla_cycle_collect,949 05:50:17 INFO - PID 13096 | __end_cc_report 05:50:17 INFO - PID 13096 | __startTimestamp1503579017554__endTimestamp 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | ------- Summary: start ------- 05:50:17 INFO - PID 13096 | Number of tests: 14 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#0] ai-astar Cycles:10 Average:104.50 Median:108.50 stddev:4.60 (4.2%) stddev-sans-first:4.00 05:50:17 INFO - PID 13096 | Values: 97.0 109.0 99.0 106.0 107.0 108.0 107.0 98.0 106.0 108.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.50 stddev:21.03 (14.3%) stddev-sans-first:21.91 05:50:17 INFO - PID 13096 | Values: 152.0 122.0 150.0 172.0 117.0 144.0 145.0 119.0 170.0 118.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.71 (1.7%) stddev-sans-first:2.85 05:50:17 INFO - PID 13096 | Values: 162.0 161.0 161.0 160.0 163.0 162.0 164.0 169.0 166.0 162.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.00 stddev:35.87 (48.5%) stddev-sans-first:37.47 05:50:17 INFO - PID 13096 | Values: 73.0 74.0 73.0 169.0 74.0 77.0 74.0 72.0 147.0 74.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:23.52 (29.8%) stddev-sans-first:24.16 05:50:17 INFO - PID 13096 | Values: 78.0 78.0 129.0 79.0 84.0 83.0 128.0 79.0 80.0 129.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:0.83 05:50:17 INFO - PID 13096 | Values: 119.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 116.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:2.01 (1.4%) stddev-sans-first:2.13 05:50:17 INFO - PID 13096 | Values: 148.0 147.0 148.0 148.0 148.0 148.0 154.0 148.0 147.0 148.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 05:50:17 INFO - PID 13096 | Values: 94.0 96.0 94.0 93.0 94.0 94.0 94.0 98.0 94.0 94.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:2.77 (5.0%) stddev-sans-first:2.85 05:50:17 INFO - PID 13096 | Values: 53.0 52.0 54.0 57.0 52.0 58.0 53.0 53.0 58.0 59.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.24 05:50:17 INFO - PID 13096 | Values: 55.0 56.0 54.0 54.0 55.0 56.0 55.0 55.0 58.0 56.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:4.77 (6.1%) stddev-sans-first:4.46 05:50:17 INFO - PID 13096 | Values: 85.0 76.0 82.0 75.0 78.0 88.0 75.0 77.0 76.0 74.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.50 stddev:14.54 (11.6%) stddev-sans-first:15.43 05:50:17 INFO - PID 13096 | Values: 126.0 118.0 131.0 115.0 126.0 125.0 120.0 120.0 116.0 165.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:174.50 stddev:6.90 (4.0%) stddev-sans-first:7.29 05:50:17 INFO - PID 13096 | Values: 177.0 172.0 171.0 186.0 188.0 172.0 170.0 170.0 179.0 169.0 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.72 (2.6%) stddev-sans-first:1.81 05:50:17 INFO - PID 13096 | Values: 65.0 65.0 65.0 68.0 63.0 64.0 67.0 66.0 68.0 64.0 05:50:17 INFO - PID 13096 | -------- Summary: end -------- 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:50:17 INFO - PID 13096 | 05:50:17 INFO - PID 13096 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:50:18 INFO - TEST-INFO | 13096: exit 0 05:50:18 INFO - TEST-OK | kraken | took 62636ms 05:50:18 INFO - SUITE-END | took 1175s 05:50:18 INFO - Completed test suite (00:19:36) 05:50:18 INFO - javascript benchmark 05:50:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8454.041667189835, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.0335700968226, 3293.7035666789984, 3305.05805845334, 3311.768176227665, 3316.535685004099, 6168.074788781685, 6240.812775616733, 6253.687315634223, 6304.0, 6324.462420694235, 6052.8486787830325, 6154.0, 6160.4763595094355, 6178.814635560941, 6197.101420294055, 5663.5186009189265, 5682.488576028157, 5683.3464151622575, 5700.458456446631, 5715.971420142893, 5721.456461636138, 5742.6841523716175, 5770.19217309577, 5772.653640781546, 5867.383924687911, 5690.516306113986, 5714.742836572344, 5743.971280143614, 5755.223044888929, 5774.624649397797, 5473.507384335429, 5562.054450743383, 5592.245046918695, 5596.58025648078, 5654.349749778787, 5635.408282130358, 5663.603547751659, 5708.315002199721, 5718.771249150029, 5719.19931209631, 6062.636241825505, 6072.939270607281, 6095.786647467362, 6126.203593532857, 6173.567850250484, 6558.573692709959, 6622.2715501294815, 6654.10169627099, 6686.197656281229, 6718.899216511756, 6680.0981867448245, 6688.264290927994, 6769.3907548320885, 6789.1174147360525, 6805.183377994672, 6210.223722034746, 6215.81352559424, 6286.025666021728, 6292.874142517124, 6304.810855674337, 6650.900236496456, 6729.629870357079, 6734.0572319875255, 6741.966290168616, 6742.123523941857, 6477.028445733178, 6480.51396145291, 6518.478521718251, 6572.441342485942, 6582.012698095324, 6589.901151482732, 6620.9006864897065, 6626.237982632059, 6654.866902662016, 6675.1989761228, 6532.444742196872, 6534.379233972765, 6534.640594767334, 6585.868282634417, 6623.470122390294, 6562.114114594564, 6601.933980660228, 6658.234303055211, 6664.200295964515, 6681.064650948871, 5251.081060814418, 5292.550133238641, 5303.840884773463, 5307.2569840222395, 5308.893822123536, 4532.27483602622, 4536.909261814745, 4623.53764623535, 4647.419072615923, 4719.339292499053, 5697.715114244271, 5704.1443783432815, 5708.771649134072, 5710.200571919934, 5713.114467257582, 6576.605403675795, 6577.934220657828, 6580.736770529221, 6580.901286480706, 6604.603723776589, 5765.221695071195, 5791.449812267828, 5794.681292528867, 5799.2750906136735, 5819.243498345188, 5679.176519404663, 5720.1991721159075, 5737.3688894221605, 5737.8565535861935, 5741.770329186786, 6310.05349197624, 6389.936100639027, 6456.967715161394, 6459.031145328145, 6517.185351831021, 6719.361660642231, 6723.529352945443, 6725.798226053226, 6738.59568425896, 6744.966275168593, 6470.126532917996, 6487.675616219264, 6548.214214294315, 6576.046473261446, 6594.0, 6555.737770489127, 6574.704138313692, 6609.339066093352, 6652.234992975869, 6653.866922661617, 6602.141721576164, 6606.669666516751, 6690.397864192051, 6756.966215169089, 6758.662066896537, 6433.806985790434, 6519.1199188110895, 6521.869562608626, 6522.478201743944, 6530.053142294436, 6465.0948867157695, 6510.121133646897, 6541.313162117909, 6555.475561955128, 6558.311377305315, 6382.393672601095, 6386.0, 6399.424051835357, 6476.287608362982, 6492.513061520311, 6482.060101285381, 6520.413162815369, 6556.442702370352, 6600.570962887397, 6605.735770569124, 6131.785387511416, 6159.81520554384, 6199.783007594893, 6210.254769427697, 6223.004319308889], "value": 6067.944834520594, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.3592550220566, 847.2417186617977, 869.7173418638944, 870.1081391573638, 1126.6620013995798, 28674.0, 29155.416891662153, 38152.618473815324, 38238.42642360367, 38441.99999999996, 38670.0, 38846.22307553847, 38938.610613893856, 38988.61011389885, 39005.609943900556, 7188.101487314086, 7582.924170758304, 7687.461877668566, 7692.846143077135, 7710.306072453478, 7534.284242996907, 7659.885101723478, 7660.578668173276, 7670.271324224218, 7679.616019199046, 7651.081870175587, 7723.073231212263, 7724.922750772476, 7726.497777644435, 7727.343175830061, 7613.162552119263, 7666.846663066735, 7669.923300767033, 7671.194524574895, 7699.576523291216, 7497.250274972514, 7568.735094271674, 7595.506292091051, 7597.962010189969, 7601.80995475112, 35393.29213415717, 35607.4658880117, 35690.0, 35696.0, 35708.10729731777, 3440.6215316315183, 3471.3577988072034, 3482.7562070655063, 3482.7562070655063, 3489.4416893296952, 30399.544006839915, 30449.695503045128, 30468.238294042603, 30478.54282185769, 30609.234769130726, 4847.757612119415, 5016.8996620067755, 5030.346055012825, 5061.468545802712, 5078.238264260353, 192013.0, 192753.0, 193181.0, 193344.0, 194377.16868493825, 45733.314000290025, 45755.31367029497, 45951.0, 45957.540424595994, 45985.31022034672, 47534.762326188145, 47646.5235347649, 47748.0, 47749.522504774504, 47795.0, 13994.0, 14649.121052736657, 14692.779608305884, 14707.41170353174, 14738.631534211516, 11655.009324207538, 12810.67973300675, 13132.474701012043, 13133.080684352004, 13175.538856139989, 13563.186208827501, 13588.728225435436, 13629.0, 13696.65758356029, 13749.725005499835, 5626.85932851682, 5679.716014199356, 5682.772689092472, 5702.144678298206, 5747.885042299131, 1003.2726273451689, 1024.3700124423574, 1027.7379268286538, 1031.7369070887025, 1042.5204405973186, 21953.121875125136, 22039.33881983543, 22172.445688857584, 22244.555108898054, 22346.0, 1113.9665810025713, 1130.8021096308114, 1131.6322195286564, 1138.7893239750672, 1142.6343570057502, 11814.232074915102, 11873.990710789507, 11880.0, 11898.345590992578, 11963.521459141537, 217845.0, 218451.0, 218711.0, 219029.0, 219348.0, 47887.521124789004, 48141.5185848144, 48165.75917120392, 48213.5178648216, 48334.758326208146, 1418.0853349589456, 1430.4063813517482, 1446.2045874769046, 1457.1912588513264, 1469.2662658063375, 21993.34019979403, 22028.88985555062, 22326.0, 22327.553448931256, 22474.0, 35106.64893351034, 35413.29173416465, 35433.46849797307, 35486.112847177996, 35601.643983559836, 186105.0, 186431.0, 186598.0, 187454.0, 187755.0, 29572.408551829274, 30144.09567712972, 30210.395792084473, 31893.362132756753, 32106.03681889547, 42064.57935420729, 42182.36726449044, 42386.788066059475, 42610.78694606507, 42700.14599708051, 30338.84830575833, 30820.38359232758, 31002.68997309998, 31321.216969575944, 31625.20936976594, 29960.700392996663, 30277.848610756806, 30725.692743073178, 30772.0, 30836.69163308428, 34413.827930860185, 34572.654273456945, 34613.48079778856, 34667.826660866536, 34719.65280347164, 29889.850550747105, 30101.397972040875, 30206.54690179693, 30229.244268893453, 30411.69588304177, 22723.659145113168, 22810.20164294242, 22944.655830162228, 23027.88486057626, 24242.51514969726], "value": 16539.14593200593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3452689509141, 548.5173047718008, 550.6971165858777, 564.1312378936436, 582.9067349224124, 21701.565968680636, 22398.88800555999, 22465.887670561624, 22481.66277505837, 22498.10007599696, 24800.0, 25151.74848251517, 25269.873650631765, 25345.239642810746, 25347.87326063367, 6513.446357059655, 6656.13470248867, 6661.16735408074, 6664.366885145928, 6670.533062685614, 5888.116782482641, 6441.742330306782, 6538.6076835389795, 6633.071370008202, 6645.269020407775, 6365.968170159166, 6400.9039864402075, 6403.263624683151, 6404.391582799627, 6404.455621272197, 6366.968165159191, 6381.744730210786, 6388.55280130391, 6402.583832050902, 6422.389872962061, 5896.439838215363, 5927.4665280125, 5958.6424814511265, 5979.880402391927, 5980.401959803985, 27966.44067118646, 28513.714862851313, 28992.0, 29098.272543186376, 29480.26299342512, 2007.3576455534235, 2036.1855257896812, 2047.1606641277153, 2048.805363490466, 2057.2593866208153, 18960.43118706441, 19341.51646208842, 19370.806291937042, 19920.203191872308, 20910.0, 2482.491089326684, 2512.459821138446, 2543.9872800636062, 2617.0578591707163, 2619.0, 134706.0, 136485.0, 137167.0, 139984.0, 140006.29996850053, 20520.301968993732, 20685.896570517052, 20788.480287992923, 21276.468088297916, 21885.890570547046, 42693.57306426958, 42763.14473710571, 42830.357544636856, 42848.14303713908, 42863.0, 10530.473476326153, 10835.67492975212, 10850.511726972305, 10922.726931826768, 10990.395528246023, 8863.867041994376, 8894.110588941054, 8897.466152030898, 8924.55377231136, 9034.32242581809, 8874.733757987271, 9249.260059195249, 9258.166764991049, 11114.0, 11473.713157171138, 2626.75045870642, 2644.180304105695, 2672.0914888937855, 2706.4316493536576, 2753.752162305402, 916.1205242966694, 966.4732720667254, 969.8642190093393, 970.1656575345197, 970.4613939263777, 19336.8066319335, 19552.120154593078, 19632.70550941737, 19716.309929152412, 19816.504587385432, 1000.8148492528906, 1018.6536577563664, 1019.4342140112161, 1022.544967489475, 1027.4605831938143, 11031.393273370042, 11033.337999720043, 11126.332420054661, 11208.887911120948, 11470.655880323604, 457255.0, 460190.0, 460631.0, 474001.0, 477381.0, 113194.0, 119625.0, 121931.39034304772, 123270.0, 124877.0, 1176.670532250971, 1201.1891972918245, 1221.3587866370226, 1227.3311045480234, 1227.5948936850818, 20096.971750624532, 20406.28577999763, 20415.489612759207, 20530.0, 20964.895175524023, 58210.126848096465, 60123.69938150281, 60178.0, 60430.697846510484, 61590.384096158465, 74354.0, 75173.62413187898, 75222.24777752372, 75652.0, 76028.61985690036, 11406.885931140914, 14207.64480887986, 14273.57179284623, 14418.639534011734, 14429.7835532465, 22454.32637020892, 22538.09847606143, 22613.0, 22735.0, 22968.655470167625, 17092.145392730563, 17148.74276885823, 17261.39585114515, 17401.21694523775, 17401.47795566135, 16269.349226030827, 16679.416220432227, 16956.91521542434, 17084.572885677957, 17181.57046073858, 17736.467905962843, 18366.173522191802, 18507.629847403245, 18520.2591896328, 18556.536086597403, 13991.16053036821, 13994.16035037901, 14092.577222683336, 14142.575722728334, 14245.074070185405, 17115.828841711424, 17304.394346198325, 17534.73697894558, 17936.641267174324, 17944.91027544854], "value": 12298.500452942882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.5291642092427, 1330.9866901330986, 1333.4932725564283, 1340.7653660609385, 1344.8251727275454, 14429.927850360747, 14926.776098358507, 14974.401023959043, 14978.251087445626, 15182.392704291815, 15148.394064237416, 15339.079655220667, 15379.769303460429, 15404.460843870467, 15413.152276624809, 2684.7181045990183, 2690.8520031398266, 2736.7400096990755, 2740.1368568900734, 2740.3149212696826, 2630.4344565918323, 2647.761701446869, 2652.0717748787865, 2657.0434643528315, 2661.5874539446418, 2745.1901689001693, 2770.570561562951, 2771.9029833955815, 2772.6118343431936, 2773.764230040449, 2642.431877146413, 2661.3213630524288, 2670.012095524649, 2671.011725661498, 2671.131882138303, 2595.1954893982925, 2598.7396112885235, 2619.1095027690485, 2629.382095207625, 2630.0, 14530.854691453056, 14671.0, 14679.77980330296, 14688.265586720621, 14704.191269480174, 7686.807829804244, 7923.524588524707, 7936.325412339958, 7946.2848343648775, 7953.801154971115, 5371.865703357408, 5472.452754724535, 5528.308961379827, 5591.161325801122, 5604.1593760935775, 1833.51411875853, 1868.4768264885854, 1874.7562816833724, 1906.5614908570967, 1908.2557802457052, 24932.50134997308, 24987.500249994897, 25166.748332516625, 25199.0, 25671.101511447196, 6605.867882642417, 6680.899786503206, 6703.229128650268, 6832.214295355998, 6867.038614593961, 16724.74912876308, 16729.916350418414, 16750.16249187536, 16750.329986800392, 16754.329826807036, 7604.315611594983, 7676.462647614613, 7707.190744971697, 7709.2290770922455, 7709.653065612061, 7069.752558660422, 7150.213476517579, 7178.0, 7200.387967022757, 7264.091988501437, 4946.629002824802, 5039.748012599355, 5068.873278168076, 5089.465606111305, 5105.897882042413, 1502.4891536877515, 1513.3038802151134, 1518.142249628956, 1531.2037740375165, 1550.759632257002, 868.1492137705085, 904.421170450912, 904.6562306323686, 911.4303560274828, 922.2990527199377, 7520.811979700442, 7562.168161502231, 7633.1985141559335, 7642.923570764332, 7708.807279818049, 697.8394969157021, 704.5244459989486, 708.373089815517, 712.6971037309227, 716.5593160206436, 5098.133317336062, 5521.779128834882, 5558.333000040021, 5685.658860468385, 5769.798057067983, 20741.170353185702, 21609.67585486219, 21624.56750864974, 21632.783672163077, 21798.237061702763, 19883.502912427015, 21016.78983210179, 21047.473813154793, 21085.367438976857, 21253.149874005176, 9844.655437059668, 10091.394516329045, 10689.412082335546, 10937.234393592373, 10985.340879547093, 8449.324054075536, 8486.660533578835, 8567.657293708431, 8676.392652514263, 8691.652333906573, 17782.0, 17860.106994650476, 17874.821251787835, 18143.727844082612, 18235.908820455814, 18367.908160459112, 18547.536311592317, 18586.535336616693, 18825.811741882953, 18989.71515427242, 11589.420528973686, 11787.0, 11809.822852657046, 11816.291022538675, 11835.28988260707, 13447.731045379232, 13615.52345667897, 13671.453141874214, 13759.17444953306, 13817.585472435843, 11148.0, 11226.270292430965, 11450.484728187084, 11586.536538538365, 11648.0, 11042.17183711241, 11103.944480277547, 11152.888471115184, 11419.200655954004, 11511.424428778695, 9781.41311521311, 9908.603655853685, 10003.34978226413, 10137.797244055226, 10138.442385668564, 6989.0995236978115, 7017.824554386181, 7116.9644151780985, 7119.288071193047, 7125.216226215009, 6986.895196571953, 7047.577145371294, 7079.929200707927, 7114.50198486101, 7151.42788576923], "value": 6539.132214806711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.3200415430859, 500.4370083655887, 502.49071116930565, 524.6065450911816, 530.5278302310944, 6294.653794041325, 6311.62130272184, 6339.366063393658, 6340.270868850078, 6354.3963323484195, 6191.690415479231, 6223.8755224895585, 6258.718357673904, 6269.373062693729, 6282.277538083122, 5142.614303927211, 5142.948570514284, 5154.381474223099, 5215.921761173586, 5217.869553261161, 4776.641751868607, 5147.433782283946, 5171.3535808024, 5171.5862730981435, 5193.402758682743, 4867.513248675122, 4881.145799485093, 4891.755412229392, 4938.950610493885, 4978.6514943953935, 4855.053264613402, 4874.3419638348905, 4923.236898280772, 4941.579965702919, 4948.7278199699, 4376.190404775127, 4404.207242696345, 4407.294832826765, 4417.0, 4454.153710794971, 6032.276126864805, 6051.152838602599, 6060.878782424327, 6061.909071363933, 6141.877162456771, 5631.845471678296, 5645.745941432645, 5668.858278543028, 5684.857878553028, 5727.369989301215, 6376.3623637635865, 6377.394147555975, 6386.265579458375, 6466.224053113657, 6508.93491065088, 4798.376211092535, 4801.303810947393, 4806.375171227753, 4821.252705830567, 4838.056578967103, 6512.967435162794, 6631.834204144935, 6669.732291021028, 6818.147731533559, 6888.655567221619, 4880.511948805091, 4893.902121957541, 4922.138625740481, 4977.129002424561, 4981.950180498221, 4941.492844682406, 4977.32806071183, 5004.42449118356, 5020.196768517019, 5039.118154322979, 5546.972265138729, 5575.832725018256, 5591.776328946878, 5621.971890140523, 5707.686077265707, 6622.933770662232, 6631.137952066297, 6650.634215118215, 6669.133012708414, 6670.866582668319, 1742.416290542657, 1744.9302027918995, 1760.64787042592, 1760.8730412535988, 1765.2762367429293, 1164.7495788405533, 1185.3480585677842, 1211.0562547111936, 1216.3492531495608, 1224.8468941382328, 5785.334686511105, 5785.942140578624, 5792.507636850831, 5792.594518383673, 5837.270341207349, 6721.798346049529, 6723.193216813916, 6725.730970761213, 6753.898691519631, 6786.219584747719, 5685.857853553694, 5697.116946873241, 5708.286464191976, 5781.19063331134, 5797.9420205797405, 3532.7880327179937, 3538.4161613333513, 3570.214552798432, 3578.8747393841613, 3581.068922080278, 6528.151340325728, 6580.309067547934, 6589.374009469093, 6592.736290548421, 6592.80221593353, 6671.532992690562, 6804.421624161902, 6867.690953907087, 6911.75808846688, 6966.164060312795, 6120.510359171167, 6370.833916468423, 6455.677216139175, 6487.643179625072, 6565.310642382577, 6713.697883595152, 6727.596344219362, 6747.797566073025, 6747.831304217434, 6752.189737231563, 6470.514711396759, 6620.5834870272965, 6679.76620818269, 6694.129763130762, 6696.0, 6429.22849258092, 6554.14796076507, 6557.737690492327, 6565.868682626417, 6626.734930602915, 4946.233333833262, 4989.525995030466, 4994.300797888372, 5018.42288136869, 5018.899622007612, 6455.935440645533, 6614.702338394687, 6623.138991931018, 6711.530192886647, 6771.424428923597, 6161.507079433545, 6392.488600911823, 6411.51913606472, 6418.775342862978, 6472.449841763503, 6394.424501794861, 6411.4870810336, 6487.935120648733, 6540.967295163494, 6558.278589355072, 6426.0, 6433.195850518685, 6466.4503517201565, 6485.221773387224, 6508.414242718178, 6448.645324507197, 6479.514036447191, 6543.5419520635005, 6586.80239592813, 6589.0, 6263.248410190807, 6320.936790632219, 6329.240491141092, 6392.296847346881, 6440.871182576228], "value": 5039.404033593348, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.8212766382892, 896.211334026057, 897.1199561894806, 907.5235501361789, 912.2610685344869, 17587.1206439678, 18338.724919126205, 18628.25486980519, 18712.719309210355, 21043.68434473484, 17831.0, 18068.186931588076, 18250.361237356694, 18421.078946052676, 18429.17068731907, 957.9664711735073, 972.1299437003877, 975.1321324021626, 975.2831668723483, 975.5073687787657, 930.9813803723921, 967.1778987860298, 967.4388854464429, 970.9854352184723, 972.5623469438746, 1006.4464544500532, 1014.4775440648073, 1017.7811770469348, 1020.9234307426973, 1021.0657248617506, 992.9751756206152, 1003.4079892863173, 1004.5931397783909, 1004.8141093897652, 1006.8036732837099, 728.3772374619676, 732.1726449112468, 738.5568658804727, 739.6930273936364, 740.4668638580214, 16957.15214239283, 17422.912885435493, 17628.735568966476, 17654.646907061786, 18186.0, 20683.793162068338, 20782.0, 21181.470463238544, 21270.787292127035, 21289.36131916045, 16880.83119168805, 16991.915040424843, 17021.234044467903, 17023.914880425644, 17480.825191748176, 3773.8679146230024, 3787.6401741834484, 3792.469054332396, 3794.772313661189, 3795.9810200949096, 127421.0, 128091.0, 129639.0, 132965.0, 134225.0, 16006.199690015686, 16166.83833161677, 16547.338106475847, 16628.33486660544, 16650.83349166517, 26708.46583068328, 26768.0, 27225.45549089007, 27376.45247095047, 29964.70035299619, 8766.649334026695, 8812.206901378906, 8822.955885220534, 8838.823223535494, 8868.33487488428, 3837.1558257183374, 4068.145689405199, 4264.104538046983, 4320.956790432056, 4322.913541729211, 5079.3650793650795, 5145.562627176732, 5176.327077479904, 5177.404598471148, 5177.58579313654, 998.3610489286863, 1007.1942446043137, 1030.2427715629008, 1037.896210378956, 1038.5949479702922, 679.1103654212997, 701.5229643842134, 711.6726305899241, 716.9459498536655, 717.3292971072065, 10935.070519005814, 11425.114856048658, 11636.825447618292, 12194.39028048594, 12588.685282867818, 635.3043417457876, 650.854496086881, 651.3746803069012, 654.6726636681659, 663.7776344924505, 5625.803096891589, 5721.713914304268, 5724.198612194296, 5853.473187413153, 6526.184226971629, 106690.46654766676, 110791.44604277088, 111111.0, 111823.44088279507, 113357.0, 92399.0, 93930.0, 96910.0, 98991.0, 99219.53512091973, 83986.0, 86512.0, 86698.56650716832, 88142.11857881467, 88785.0, 11488.942555287504, 11959.940200298943, 12117.0, 12148.939255303667, 12658.11393202467, 38100.61899380971, 39206.21587568176, 39888.0, 41417.58582414137, 41999.370009449274, 50579.0, 52177.0, 52675.47324526706, 54366.0, 70697.29302707112, 18166.09169541491, 18916.33792817245, 18987.715184271972, 19097.618047639247, 19245.80754192496, 21362.252321168686, 21435.46411339729, 21443.035063422496, 21489.14043438245, 21500.354989350344, 17937.461876143738, 18832.24671013144, 18921.053947302855, 19455.0, 19670.0, 19119.330823421114, 19184.90407547953, 19233.90383048076, 19250.903745481184, 19769.308074217333, 16688.916555417145, 16760.58098547546, 16763.664726705643, 17380.39168629092, 17831.821681783014, 12436.813447798471, 12547.623571292876, 12630.747385052064, 12726.68183295425, 13187.340632968506, 13245.337733113498, 13249.735005299648, 13379.397927093109, 13383.0, 13390.062695611214], "value": 8975.409049782227, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 99.0, 106.0, 107.0, 108.0, 107.0, 98.0, 106.0, 108.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 150.0, 172.0, 117.0, 144.0, 145.0, 119.0, 170.0, 118.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 163.0, 162.0, 164.0, 169.0, 166.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 169.0, 74.0, 77.0, 74.0, 72.0, 147.0, 74.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 129.0, 79.0, 84.0, 83.0, 128.0, 79.0, 80.0, 129.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 154.0, 148.0, 147.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 98.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 57.0, 52.0, 58.0, 53.0, 53.0, 58.0, 59.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0, 58.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 82.0, 75.0, 78.0, 88.0, 75.0, 77.0, 76.0, 74.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 118.0, 131.0, 115.0, 126.0, 125.0, 120.0, 120.0, 116.0, 165.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 171.0, 186.0, 188.0, 172.0, 170.0, 170.0, 179.0, 169.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 68.0, 63.0, 64.0, 67.0, 66.0, 68.0, 64.0], "value": 65.5, "unit": "score"}]}]} 05:50:18 INFO - Return code: 0 05:50:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:18 INFO - # TBPL SUCCESS # 05:50:18 INFO - Running post-action listener: _package_coverage_data 05:50:18 INFO - Running post-action listener: _resource_record_post_action 05:50:18 INFO - [mozharness: 2017-08-24 12:50:18.865284Z] Finished run-tests step (success) 05:50:18 INFO - Running post-run listener: _resource_record_post_run 05:50:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439152640; Read time: 12; Write time: 912792 05:50:18 INFO - TinderboxPrint: CPU usage
13.2% 05:50:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:50:18 INFO - TinderboxPrint: I/O write bytes / time
439,152,640 / 912,792 05:50:18 INFO - TinderboxPrint: CPU idle
8,263.5 (86.8%) 05:50:18 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 05:50:18 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:18 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 116555776; Read time: 0; Write time: 309136 05:50:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:50:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 322596864; Read time: 0; Write time: 603656 05:50:19 INFO - Running post-run listener: _upload_blobber_files 05:50:19 INFO - Blob upload gear active. 05:50:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:19 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 05:50:19 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'] 05:50:19 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 05:50:19 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:50:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:20 INFO - (blobuploader) - INFO - Done attempting. 05:50:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:27 INFO - (blobuploader) - INFO - Done attempting. 05:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:28 INFO - (blobuploader) - INFO - Done attempting. 05:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:29 INFO - (blobuploader) - INFO - Done attempting. 05:50:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:29 INFO - Return code: 0 05:50:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90a2e412242e3395d5deebab3b7f2fe1758414c9d020bc146355b79673abb155f16c7e02ec5919973fe52f31bf1af7c3854e2d68deab0429ddf7147f0dbe7e0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f301e62ffdbe67ced5df4d7bba8540d4c27b50bc0d3e0ec0da86991f063c84a7d3f90afa9dff7bf9c872bdbfd658b380af00b1f2eb8a1266dfa0968bf996e9e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96a16f989e1c8f4d97c57a335bbb000cbdf70e5b9db50fabfadd28964f2c03e0208e801e60e7a19fc7dc1a400f84459894b371dde565ab0ae7b0e38851bc9992", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b7eed8fd89dd0084ea381b885b41b8126c61f02b31284454e3f85e28c79119e08e4321cb717971a34382828fea17ae670f63e83d45f4e684f0dc6c3c272e6e"} 05:50:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:29 INFO - Contents: 05:50:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90a2e412242e3395d5deebab3b7f2fe1758414c9d020bc146355b79673abb155f16c7e02ec5919973fe52f31bf1af7c3854e2d68deab0429ddf7147f0dbe7e0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f301e62ffdbe67ced5df4d7bba8540d4c27b50bc0d3e0ec0da86991f063c84a7d3f90afa9dff7bf9c872bdbfd658b380af00b1f2eb8a1266dfa0968bf996e9e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96a16f989e1c8f4d97c57a335bbb000cbdf70e5b9db50fabfadd28964f2c03e0208e801e60e7a19fc7dc1a400f84459894b371dde565ab0ae7b0e38851bc9992", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b7eed8fd89dd0084ea381b885b41b8126c61f02b31284454e3f85e28c79119e08e4321cb717971a34382828fea17ae670f63e83d45f4e684f0dc6c3c272e6e"} 05:50:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:29 INFO - Copying logs to upload dir... 05:50:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.879958 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-24 05:50:29.064914) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:50:29.072116) ========= 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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90a2e412242e3395d5deebab3b7f2fe1758414c9d020bc146355b79673abb155f16c7e02ec5919973fe52f31bf1af7c3854e2d68deab0429ddf7147f0dbe7e0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f301e62ffdbe67ced5df4d7bba8540d4c27b50bc0d3e0ec0da86991f063c84a7d3f90afa9dff7bf9c872bdbfd658b380af00b1f2eb8a1266dfa0968bf996e9e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96a16f989e1c8f4d97c57a335bbb000cbdf70e5b9db50fabfadd28964f2c03e0208e801e60e7a19fc7dc1a400f84459894b371dde565ab0ae7b0e38851bc9992", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b7eed8fd89dd0084ea381b885b41b8126c61f02b31284454e3f85e28c79119e08e4321cb717971a34382828fea17ae670f63e83d45f4e684f0dc6c3c272e6e"} build_url:https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/edDsDxIfTzGMCiv9-pbWyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90a2e412242e3395d5deebab3b7f2fe1758414c9d020bc146355b79673abb155f16c7e02ec5919973fe52f31bf1af7c3854e2d68deab0429ddf7147f0dbe7e0a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f301e62ffdbe67ced5df4d7bba8540d4c27b50bc0d3e0ec0da86991f063c84a7d3f90afa9dff7bf9c872bdbfd658b380af00b1f2eb8a1266dfa0968bf996e9e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96a16f989e1c8f4d97c57a335bbb000cbdf70e5b9db50fabfadd28964f2c03e0208e801e60e7a19fc7dc1a400f84459894b371dde565ab0ae7b0e38851bc9992", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b7eed8fd89dd0084ea381b885b41b8126c61f02b31284454e3f85e28c79119e08e4321cb717971a34382828fea17ae670f63e83d45f4e684f0dc6c3c272e6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 05:50:29.101624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:50:29.101976) ========= 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=8783db0840cc980e80bb0bd400000236-1503577764.367774-797927899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:50:29.183634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:50:29.187043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 05:50:29.187390) ========= ========= Total master_lag: 0.30 =========