builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1506356599.26 results: success (0) revision: c3f480fa9744b65485b77e5d67768a9dbf075752 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.259440) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.259870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.260158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.276844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.277156) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 09:23:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2017-09-25 09:23:19 (39.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.421598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.421925) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:19.471107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 09:23:19.472988) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c3f480fa9744b65485b77e5d67768a9dbf075752 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c3f480fa9744b65485b77e5d67768a9dbf075752 --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=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 09:23:19,534 truncating revision to first 12 chars 2017-09-25 09:23:19,534 Setting DEBUG logging. 2017-09-25 09:23:19,534 attempt 1/10 2017-09-25 09:23:19,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c3f480fa9744?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 09:23:20,433 unpacking tar archive at: mozilla-beta-c3f480fa9744/testing/mozharness/ program finished with exit code 0 elapsedTime=1.217736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 09:23:20.706750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:20.707112) ========= script_repo_revision: c3f480fa9744b65485b77e5d67768a9dbf075752 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:20.710506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:20.710771) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 09:23:20.724330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-25 09:23:20.724711) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:20 INFO - MultiFileLogger online at 20170925 09:23:20 in /builds/slave/test 09:23:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 09:23:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:20 INFO - {'append_to_log': False, 09:23:20 INFO - 'base_work_dir': '/builds/slave/test', 09:23:20 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 09:23:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:20 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 09:23:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:20 INFO - 'code_coverage': False, 09:23:20 INFO - 'config_files': ('talos/linux_config.py',), 09:23:20 INFO - 'default_actions': ('clobber', 09:23:20 INFO - 'read-buildbot-config', 09:23:20 INFO - 'download-and-extract', 09:23:20 INFO - 'populate-webroot', 09:23:20 INFO - 'create-virtualenv', 09:23:20 INFO - 'install', 09:23:20 INFO - 'setup-mitmproxy', 09:23:20 INFO - 'run-tests'), 09:23:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:20 INFO - 'disable_ccov_upload': False, 09:23:20 INFO - 'disable_stylo': False, 09:23:20 INFO - 'download_minidump_stackwalk': True, 09:23:20 INFO - 'download_symbols': 'ondemand', 09:23:20 INFO - 'enable_stylo': False, 09:23:20 INFO - 'enable_webrender': False, 09:23:20 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 09:23:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:20 INFO - 'gecko_profile': False, 09:23:20 INFO - 'gecko_profile_interval': 0, 09:23:20 INFO - 'installer_path': 'installer.exe', 09:23:20 INFO - 'log_level': 'info', 09:23:20 INFO - 'log_name': 'talos', 09:23:20 INFO - 'log_to_console': True, 09:23:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:20 INFO - 'opt_config_files': (), 09:23:20 INFO - 'pip_index': False, 09:23:20 INFO - 'suite': 'dromaeojs-e10s', 09:23:20 INFO - 'system_bits': '32', 09:23:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:20 INFO - 'title': 'talos-linux64-ix-075', 09:23:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:20 INFO - 'use_talos_json': True, 09:23:20 INFO - 'verify': 'False', 09:23:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:20 INFO - 'work_dir': 'build'} 09:23:20 INFO - [mozharness: 2017-09-25 16:23:20.926159Z] Running clobber step. 09:23:20 INFO - Running pre-action listener: _resource_record_pre_action 09:23:20 INFO - Running main action method: clobber 09:23:20 INFO - rmtree: /builds/slave/test/build 09:23:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:22 INFO - Running post-action listener: _resource_record_post_action 09:23:22 INFO - [mozharness: 2017-09-25 16:23:22.461903Z] Finished clobber step (success) 09:23:22 INFO - [mozharness: 2017-09-25 16:23:22.462001Z] Running read-buildbot-config step. 09:23:22 INFO - Running pre-action listener: _resource_record_pre_action 09:23:22 INFO - Running main action method: read_buildbot_config 09:23:22 INFO - Using buildbot properties: 09:23:22 INFO - { 09:23:22 INFO - "project": "", 09:23:22 INFO - "product": "firefox", 09:23:22 INFO - "who": "ryanvm@gmail.com", 09:23:22 INFO - "installer_path": "public/build/target.tar.bz2", 09:23:22 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:23:22 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 09:23:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 09:23:22 INFO - "stage_platform": "linux64", 09:23:22 INFO - "basedir": "/builds/slave/test", 09:23:22 INFO - "buildnumber": 125, 09:23:22 INFO - "platform": "ubuntu64_hw", 09:23:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:23:22 INFO - "slavebuilddir": "test", 09:23:22 INFO - "taskId": "HUDWdxkERUKHIoW0gKG6Kw", 09:23:22 INFO - "branch": "mozilla-beta", 09:23:22 INFO - "script_repo_revision": "production", 09:23:22 INFO - "revision": "c3f480fa9744b65485b77e5d67768a9dbf075752", 09:23:22 INFO - "slavename": "talos-linux64-ix-075", 09:23:22 INFO - "repo_path": "releases/mozilla-beta" 09:23:22 INFO - } 09:23:22 INFO - Finding installer, test and symbols from parent task. 09:23:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUDWdxkERUKHIoW0gKG6Kw'}, attempt #1 09:23:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HUDWdxkERUKHIoW0gKG6Kw'}, attempt #1 09:23:23 INFO - Task dependencies: L2rPmNg3Rf2OevR9h6zgOw 09:23:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw'}, attempt #1 09:23:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 09:23:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.test_packages.json 09:23:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.crashreporter-symbols.zip 09:23:23 INFO - Running post-action listener: _resource_record_post_action 09:23:23 INFO - [mozharness: 2017-09-25 16:23:23.916930Z] Finished read-buildbot-config step (success) 09:23:23 INFO - [mozharness: 2017-09-25 16:23:23.917190Z] Running download-and-extract step. 09:23:23 INFO - Running pre-action listener: _resource_record_pre_action 09:23:23 INFO - Running main action method: download_and_extract 09:23:23 INFO - mkdir: /builds/slave/test/build/tests 09:23: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')]} 09:23:23 INFO - trying https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.test_packages.json 09:23:23 INFO - Downloading https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:23:24 INFO - Downloaded 989 bytes. 09:23:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:23:24 INFO - Using the following test package requirements: 09:23:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:23:24 INFO - u'common': [u'target.common.tests.zip'], 09:23:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:23:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:23:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:23:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:23:24 INFO - u'mozbase': [u'target.common.tests.zip'], 09:23:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:23:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:23:24 INFO - u'web-platform': [u'target.common.tests.zip', 09:23:24 INFO - u'target.web-platform.tests.tar.gz'], 09:23:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:23:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 09:23:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.common.tests.zip 09:23:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:23:24 INFO - Fetch https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.common.tests.zip into memory 09:23:25 INFO - Content-Length response header: 55181805 09:23:25 INFO - Bytes received: 55181805 09:23:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.talos.tests.zip 09:23:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:36 INFO - Fetch https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.talos.tests.zip into memory 09:23:37 INFO - Content-Length response header: 14509184 09:23:37 INFO - Bytes received: 14509184 09:23:37 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')]} 09:23:37 INFO - trying https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 09:23:37 INFO - Downloading https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:38 INFO - Downloaded 53440726 bytes. 09:23:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 09:23:38 INFO - mkdir: /builds/slave/test/properties 09:23:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:38 INFO - Contents: 09:23:38 INFO - build_url:https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 09:23:38 INFO - Running post-action listener: _resource_record_post_action 09:23:38 INFO - Running post-action listener: find_tests_for_verification 09:23:38 INFO - Running post-action listener: set_extra_try_arguments 09:23:38 INFO - [mozharness: 2017-09-25 16:23:38.589166Z] Finished download-and-extract step (success) 09:23:38 INFO - [mozharness: 2017-09-25 16:23:38.589263Z] Running populate-webroot step. 09:23:38 INFO - Running pre-action listener: _resource_record_pre_action 09:23:38 INFO - Running main action method: populate_webroot 09:23:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['tresize', 09:23:38 INFO - 'tcanvasmark']}, 09:23:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['dromaeo_css', 09:23:38 INFO - 'kraken']}, 09:23:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'tests': ['damp', 'tps']}, 09:23:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['damp', 'tps']}, 09:23:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['dromaeo_dom']}, 09:23:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['basic_compositor_video', 09:23:38 INFO - 'glvideo']}, 09:23:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:23:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['ts_paint_webext', 09:23:38 INFO - 'tp5o_webext']}, 09:23:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:38 INFO - 'ts_paint', 09:23:38 INFO - 'tpaint', 09:23:38 INFO - 'sessionrestore', 09:23:38 INFO - 'sessionrestore_many_windows', 09:23:38 INFO - 'sessionrestore_no_auto_restore', 09:23:38 INFO - 'tabpaint']}, 09:23:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['a11yr', 09:23:38 INFO - 'ts_paint', 09:23:38 INFO - 'tpaint', 09:23:38 INFO - 'sessionrestore', 09:23:38 INFO - 'sessionrestore_many_windows', 09:23:38 INFO - 'sessionrestore_no_auto_restore', 09:23:38 INFO - 'tabpaint']}, 09:23:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:23:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 09:23:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['perf_reftest_singletons']}, 09:23:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['bloom_basic']}, 09:23:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:38 INFO - 'tsvgr_opacity', 09:23:38 INFO - 'tart', 09:23:38 INFO - 'tscrollx', 09:23:38 INFO - 'tsvg_static']}, 09:23:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['tsvgx', 09:23:38 INFO - 'tsvgr_opacity', 09:23:38 INFO - 'tart', 09:23:38 INFO - 'tscrollx', 09:23:38 INFO - 'tsvg_static']}, 09:23:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo'], 09:23:38 INFO - 'tests': ['tp5o']}, 09:23:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:38 INFO - 'talos_options': ['--mitmproxy', 09:23:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:38 INFO - '--firstNonBlankPaint'], 09:23:38 INFO - 'tests': ['tp6_google', 09:23:38 INFO - 'tp6_youtube', 09:23:38 INFO - 'tp6_amazon', 09:23:38 INFO - 'tp6_facebook']}, 09:23:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo', 09:23:38 INFO - '--mitmproxy', 09:23:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:38 INFO - '--firstNonBlankPaint'], 09:23:38 INFO - 'tests': ['tp6_google', 09:23:38 INFO - 'tp6_youtube', 09:23:38 INFO - 'tp6_amazon', 09:23:38 INFO - 'tp6_facebook']}, 09:23:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:38 INFO - 'talos_options': ['--stylo-threads=1', 09:23:38 INFO - '--mitmproxy', 09:23:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:38 INFO - '--firstNonBlankPaint'], 09:23:38 INFO - 'tests': ['tp6_google', 09:23:38 INFO - 'tp6_youtube', 09:23:38 INFO - 'tp6_amazon', 09:23:38 INFO - 'tp6_facebook']}, 09:23:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--xperf_path', 09:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:38 INFO - 'tests': ['tp5n']}, 09:23:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 09:23:38 INFO - 'talos_options': ['--disable-stylo', 09:23:38 INFO - '--xperf_path', 09:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:38 INFO - 'tests': ['tp5n']}}} 09:23:38 INFO - Running post-action listener: _resource_record_post_action 09:23:38 INFO - [mozharness: 2017-09-25 16:23:38.604317Z] Finished populate-webroot step (success) 09:23:38 INFO - [mozharness: 2017-09-25 16:23:38.604406Z] Running create-virtualenv step. 09:23:38 INFO - Running pre-action listener: _resource_record_pre_action 09:23:38 INFO - Running main action method: create_virtualenv 09:23:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 09:23:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:23:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:39 INFO - Installing pip...............done. 09:23:39 INFO - Return code: 0 09:23:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:39 INFO - Reading from file tmpfile_stdout 09:23:39 INFO - Output received: 09:23:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 09:23:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:39 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')]} 09:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:39 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')]} 09:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:39 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:39 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 09:23:39 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 09:23:39 INFO - Using env: {'DISPLAY': ':0', 09:23:39 INFO - 'HOME': '/home/cltbld', 09:23:39 INFO - 'LANG': 'en_US.UTF-8', 09:23:39 INFO - 'LANGUAGE': 'en_US:en', 09:23:39 INFO - 'LOGNAME': 'cltbld', 09:23:39 INFO - 'MAIL': '/var/mail/cltbld', 09:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:39 INFO - 'MOZ_NO_REMOTE': '1', 09:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:39 INFO - 'NO_EM_RESTART': '1', 09:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:39 INFO - 'PWD': '/builds/slave/test', 09:23:39 INFO - 'SHELL': '/bin/bash', 09:23:39 INFO - 'SHLVL': '1', 09:23:39 INFO - 'TERM': 'linux', 09:23:39 INFO - 'TMOUT': '86400', 09:23:39 INFO - 'USER': 'cltbld', 09:23:39 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:39 INFO - '_': '/tools/buildbot/bin/python'} 09:23:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 09:23:40 INFO - Downloading/unpacking pip>=1.5 09:23:40 INFO - Running setup.py egg_info for package pip 09:23:40 INFO - warning: no files found matching 'pip/cacert.pem' 09:23:40 INFO - warning: no files found matching '*.html' under directory 'docs' 09:23:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:23:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:23:40 INFO - Installing collected packages: pip 09:23:40 INFO - Found existing installation: pip 1.1 09:23:40 INFO - Uninstalling pip: 09:23:40 INFO - Successfully uninstalled pip 09:23:40 INFO - Running setup.py install for pip 09:23:40 INFO - warning: no files found matching 'pip/cacert.pem' 09:23:40 INFO - warning: no files found matching '*.html' under directory 'docs' 09:23:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 09:23:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 09:23:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 09:23:40 INFO - Successfully installed pip 09:23:40 INFO - Cleaning up... 09:23:40 INFO - Return code: 0 09:23:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:40 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:40 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 09:23:40 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 09:23:40 INFO - Using env: {'DISPLAY': ':0', 09:23:40 INFO - 'HOME': '/home/cltbld', 09:23:40 INFO - 'LANG': 'en_US.UTF-8', 09:23:40 INFO - 'LANGUAGE': 'en_US:en', 09:23:40 INFO - 'LOGNAME': 'cltbld', 09:23:40 INFO - 'MAIL': '/var/mail/cltbld', 09:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:40 INFO - 'MOZ_NO_REMOTE': '1', 09:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:40 INFO - 'NO_EM_RESTART': '1', 09:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:40 INFO - 'PWD': '/builds/slave/test', 09:23:40 INFO - 'SHELL': '/bin/bash', 09:23:40 INFO - 'SHLVL': '1', 09:23:40 INFO - 'TERM': 'linux', 09:23:40 INFO - 'TMOUT': '86400', 09:23:40 INFO - 'USER': 'cltbld', 09:23:40 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:40 INFO - '_': '/tools/buildbot/bin/python'} 09:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:41 INFO - Downloading/unpacking psutil>=3.1.1 09:23:41 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 09:23:41 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 09:23:41 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 09:23:41 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 09:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:43 INFO - Installing collected packages: psutil 09:23:43 INFO - Running setup.py install for psutil 09:23:43 INFO - building 'psutil._psutil_linux' extension 09:23:43 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 09:23:43 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 09:23:43 INFO - building 'psutil._psutil_posix' extension 09:23:43 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 09:23:43 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 09:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:43 INFO - Successfully installed psutil 09:23:43 INFO - Cleaning up... 09:23:43 INFO - Return code: 0 09:23:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:43 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')]} 09:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:43 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')]} 09:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:43 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 09:23:43 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 09:23:43 INFO - Using env: {'DISPLAY': ':0', 09:23:43 INFO - 'HOME': '/home/cltbld', 09:23:43 INFO - 'LANG': 'en_US.UTF-8', 09:23:43 INFO - 'LANGUAGE': 'en_US:en', 09:23:43 INFO - 'LOGNAME': 'cltbld', 09:23:43 INFO - 'MAIL': '/var/mail/cltbld', 09:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:43 INFO - 'MOZ_NO_REMOTE': '1', 09:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:43 INFO - 'NO_EM_RESTART': '1', 09:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:43 INFO - 'PWD': '/builds/slave/test', 09:23:43 INFO - 'SHELL': '/bin/bash', 09:23:43 INFO - 'SHLVL': '1', 09:23:43 INFO - 'TERM': 'linux', 09:23:43 INFO - 'TMOUT': '86400', 09:23:43 INFO - 'USER': 'cltbld', 09:23:43 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:43 INFO - '_': '/tools/buildbot/bin/python'} 09:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:45 INFO - Installing collected packages: mozsystemmonitor 09:23:45 INFO - Running setup.py install for mozsystemmonitor 09:23:45 INFO - Successfully installed mozsystemmonitor 09:23:45 INFO - Cleaning up... 09:23:45 INFO - Return code: 0 09:23:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:45 INFO - Using env: {'DISPLAY': ':0', 09:23:45 INFO - 'HOME': '/home/cltbld', 09:23:45 INFO - 'LANG': 'en_US.UTF-8', 09:23:45 INFO - 'LANGUAGE': 'en_US:en', 09:23:45 INFO - 'LOGNAME': 'cltbld', 09:23:45 INFO - 'MAIL': '/var/mail/cltbld', 09:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:45 INFO - 'MOZ_NO_REMOTE': '1', 09:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:45 INFO - 'NO_EM_RESTART': '1', 09:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:45 INFO - 'PWD': '/builds/slave/test', 09:23:45 INFO - 'SHELL': '/bin/bash', 09:23:45 INFO - 'SHLVL': '1', 09:23:45 INFO - 'TERM': 'linux', 09:23:45 INFO - 'TMOUT': '86400', 09:23:45 INFO - 'USER': 'cltbld', 09:23:45 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:45 INFO - '_': '/tools/buildbot/bin/python'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:45 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 09:23:45 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 09:23:45 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 09:23:45 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 09:23:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:47 INFO - warning: no files found matching '*.txt' 09:23:47 INFO - no previously-included directories found matching 'build' 09:23:47 INFO - no previously-included directories found matching 'dist' 09:23:47 INFO - no previously-included directories found matching '.git*' 09:23:47 INFO - Installing collected packages: jsonschema, functools32 09:23:47 INFO - Running setup.py install for functools32 09:23:47 INFO - warning: no files found matching '*.txt' 09:23:47 INFO - no previously-included directories found matching 'build' 09:23:47 INFO - no previously-included directories found matching 'dist' 09:23:47 INFO - no previously-included directories found matching '.git*' 09:23:47 INFO - Successfully installed jsonschema functools32 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:23:47 INFO - Using env: {'DISPLAY': ':0', 09:23:47 INFO - 'HOME': '/home/cltbld', 09:23:47 INFO - 'LANG': 'en_US.UTF-8', 09:23:47 INFO - 'LANGUAGE': 'en_US:en', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MAIL': '/var/mail/cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SHLVL': '1', 09:23:47 INFO - 'TERM': 'linux', 09:23:47 INFO - 'TMOUT': '86400', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - '_': '/tools/buildbot/bin/python'} 09:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:23:47 INFO - Using env: {'DISPLAY': ':0', 09:23:47 INFO - 'HOME': '/home/cltbld', 09:23:47 INFO - 'LANG': 'en_US.UTF-8', 09:23:47 INFO - 'LANGUAGE': 'en_US:en', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MAIL': '/var/mail/cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SHLVL': '1', 09:23:47 INFO - 'TERM': 'linux', 09:23:47 INFO - 'TMOUT': '86400', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - '_': '/tools/buildbot/bin/python'} 09:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:48 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 09:23:48 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 09:23:48 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 09:23:48 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 09:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:49 INFO - Downloading docopt-0.6.1.tar.gz 09:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:49 INFO - Running setup.py install for blobuploader 09:23:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:49 INFO - Running setup.py install for requests 09:23:49 INFO - Running setup.py install for docopt 09:23:49 INFO - Successfully installed blobuploader requests docopt 09:23:49 INFO - Cleaning up... 09:23:50 INFO - Return code: 0 09:23:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:50 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')]} 09:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:50 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')]} 09:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:50 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:50 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 09:23:50 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 09:23:50 INFO - Using env: {'DISPLAY': ':0', 09:23:50 INFO - 'HOME': '/home/cltbld', 09:23:50 INFO - 'LANG': 'en_US.UTF-8', 09:23:50 INFO - 'LANGUAGE': 'en_US:en', 09:23:50 INFO - 'LOGNAME': 'cltbld', 09:23:50 INFO - 'MAIL': '/var/mail/cltbld', 09:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:50 INFO - 'MOZ_NO_REMOTE': '1', 09:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:50 INFO - 'NO_EM_RESTART': '1', 09:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:50 INFO - 'PWD': '/builds/slave/test', 09:23:50 INFO - 'SHELL': '/bin/bash', 09:23:50 INFO - 'SHLVL': '1', 09:23:50 INFO - 'TERM': 'linux', 09:23:50 INFO - 'TMOUT': '86400', 09:23:50 INFO - 'USER': 'cltbld', 09:23:50 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:50 INFO - '_': '/tools/buildbot/bin/python'} 09:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:50 INFO - Running setup.py (path:/tmp/pip-uQ1M_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:50 INFO - Running setup.py (path:/tmp/pip-vMxUGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:50 INFO - Running setup.py (path:/tmp/pip-f1G2QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:50 INFO - Running setup.py (path:/tmp/pip-pn901q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:50 INFO - Running setup.py (path:/tmp/pip-U03Nkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:50 INFO - Running setup.py (path:/tmp/pip-q5pFPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:50 INFO - Running setup.py (path:/tmp/pip-DAh2wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:50 INFO - Running setup.py (path:/tmp/pip-PQ5EwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:50 INFO - Running setup.py (path:/tmp/pip-0IUhzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:50 INFO - Running setup.py (path:/tmp/pip-sboFSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:50 INFO - Running setup.py (path:/tmp/pip-oP3VX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:51 INFO - Running setup.py (path:/tmp/pip-bM6RD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:51 INFO - Running setup.py (path:/tmp/pip-KkioL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:51 INFO - Running setup.py (path:/tmp/pip-3G30HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:51 INFO - Running setup.py (path:/tmp/pip-7SKscG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:51 INFO - Running setup.py (path:/tmp/pip-bQZyXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:51 INFO - Running setup.py (path:/tmp/pip-AUrRnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:51 INFO - Running setup.py install for manifestparser 09:23:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozcrash 09:23:51 INFO - Running setup.py install for mozdebug 09:23:51 INFO - Running setup.py install for mozdevice 09:23:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozfile 09:23:51 INFO - Running setup.py install for mozhttpd 09:23:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozinfo 09:23:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozInstall 09:23:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozleak 09:23:52 INFO - Running setup.py install for mozlog 09:23:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for moznetwork 09:23:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozprocess 09:23:52 INFO - Running setup.py install for mozprofile 09:23:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozrunner 09:23:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:52 INFO - Running setup.py install for mozscreenshot 09:23:52 INFO - Running setup.py install for moztest 09:23:53 INFO - Running setup.py install for mozversion 09:23:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:53 INFO - Cleaning up... 09:23:53 INFO - Return code: 0 09:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:53 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')]} 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:53 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')]} 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:53 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:53 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 09:23:53 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 09:23:53 INFO - Using env: {'DISPLAY': ':0', 09:23:53 INFO - 'HOME': '/home/cltbld', 09:23:53 INFO - 'LANG': 'en_US.UTF-8', 09:23:53 INFO - 'LANGUAGE': 'en_US:en', 09:23:53 INFO - 'LOGNAME': 'cltbld', 09:23:53 INFO - 'MAIL': '/var/mail/cltbld', 09:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:53 INFO - 'MOZ_NO_REMOTE': '1', 09:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:53 INFO - 'NO_EM_RESTART': '1', 09:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:53 INFO - 'PWD': '/builds/slave/test', 09:23:53 INFO - 'SHELL': '/bin/bash', 09:23:53 INFO - 'SHLVL': '1', 09:23:53 INFO - 'TERM': 'linux', 09:23:53 INFO - 'TMOUT': '86400', 09:23:53 INFO - 'USER': 'cltbld', 09:23:53 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:53 INFO - '_': '/tools/buildbot/bin/python'} 09:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:53 INFO - Running setup.py (path:/tmp/pip-W33tT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:53 INFO - Running setup.py (path:/tmp/pip-2O2pdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:53 INFO - Running setup.py (path:/tmp/pip-D5qAj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:53 INFO - Running setup.py (path:/tmp/pip-RGvpar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:53 INFO - Running setup.py (path:/tmp/pip-6N2gdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:53 INFO - Running setup.py (path:/tmp/pip-8sTuFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:53 INFO - Running setup.py (path:/tmp/pip-2kodUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:53 INFO - Running setup.py (path:/tmp/pip-95Gkmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:54 INFO - Running setup.py (path:/tmp/pip-UKUhXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:54 INFO - Running setup.py (path:/tmp/pip-BCg67b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:54 INFO - Running setup.py (path:/tmp/pip-SNfc7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:54 INFO - Running setup.py (path:/tmp/pip-8mjjJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:54 INFO - Running setup.py (path:/tmp/pip-sEo3EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:54 INFO - Running setup.py (path:/tmp/pip-4ip5cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:54 INFO - Running setup.py (path:/tmp/pip-SXKjzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:54 INFO - Running setup.py (path:/tmp/pip-QWF1Ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:54 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)) 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:54 INFO - Running setup.py (path:/tmp/pip-TlwjYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:54 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)) 09:23:54 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)) 09:23:54 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)) 09:23:54 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)) 09:23:54 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)) 09:23:54 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)) 09:23:54 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)) 09:23:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:55 INFO - Downloading blessings-1.6.tar.gz 09:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:55 INFO - Installing collected packages: blessings 09:23:55 INFO - Running setup.py install for blessings 09:23:55 INFO - Successfully installed blessings 09:23:55 INFO - Cleaning up... 09:23:55 INFO - Return code: 0 09:23:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:56 INFO - Reading from file tmpfile_stdout 09:23:56 INFO - Current package versions: 09:23:56 INFO - argparse == 1.2.1 09:23:56 INFO - blessings == 1.6 09:23:56 INFO - blobuploader == 1.2.4 09:23:56 INFO - docopt == 0.6.1 09:23:56 INFO - functools32 == 3.2.3-2 09:23:56 INFO - jsonschema == 2.5.1 09:23:56 INFO - manifestparser == 1.1 09:23:56 INFO - mozInstall == 1.13 09:23:56 INFO - mozcrash == 1.0 09:23:56 INFO - mozdebug == 0.1 09:23:56 INFO - mozdevice == 0.51 09:23:56 INFO - mozfile == 1.2 09:23:56 INFO - mozhttpd == 0.7 09:23:56 INFO - mozinfo == 0.10 09:23:56 INFO - mozleak == 0.1 09:23:56 INFO - mozlog == 3.5 09:23:56 INFO - moznetwork == 0.27 09:23:56 INFO - mozprocess == 0.25 09:23:56 INFO - mozprofile == 0.28 09:23:56 INFO - mozrunner == 6.13 09:23:56 INFO - mozscreenshot == 0.1 09:23:56 INFO - mozsystemmonitor == 0.3 09:23:56 INFO - moztest == 0.8 09:23:56 INFO - mozversion == 1.4 09:23:56 INFO - psutil == 3.1.1 09:23:56 INFO - requests == 1.2.3 09:23:56 INFO - wsgiref == 0.1.2 09:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:56 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')]} 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:56 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')]} 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:56 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:56 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 09:23:56 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 09:23:56 INFO - Using env: {'DISPLAY': ':0', 09:23:56 INFO - 'HOME': '/home/cltbld', 09:23:56 INFO - 'LANG': 'en_US.UTF-8', 09:23:56 INFO - 'LANGUAGE': 'en_US:en', 09:23:56 INFO - 'LOGNAME': 'cltbld', 09:23:56 INFO - 'MAIL': '/var/mail/cltbld', 09:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:56 INFO - 'MOZ_NO_REMOTE': '1', 09:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:56 INFO - 'NO_EM_RESTART': '1', 09:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:56 INFO - 'PWD': '/builds/slave/test', 09:23:56 INFO - 'SHELL': '/bin/bash', 09:23:56 INFO - 'SHLVL': '1', 09:23:56 INFO - 'TERM': 'linux', 09:23:56 INFO - 'TMOUT': '86400', 09:23:56 INFO - 'USER': 'cltbld', 09:23:56 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:56 INFO - '_': '/tools/buildbot/bin/python'} 09:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:23:57 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)) 09:23:57 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)) 09:23:57 INFO - Installing collected packages: simplejson 09:23:57 INFO - Running setup.py install for simplejson 09:23:57 INFO - building 'simplejson._speedups' extension 09:23:57 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 09:23:58 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 09:23:58 INFO - Successfully installed simplejson 09:23:58 INFO - Cleaning up... 09:23:58 INFO - Return code: 0 09:23:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, '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': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', '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 09:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:58 INFO - Using env: {'DISPLAY': ':0', 09:23:58 INFO - 'HOME': '/home/cltbld', 09:23:58 INFO - 'LANG': 'en_US.UTF-8', 09:23:58 INFO - 'LANGUAGE': 'en_US:en', 09:23:58 INFO - 'LOGNAME': 'cltbld', 09:23:58 INFO - 'MAIL': '/var/mail/cltbld', 09:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:58 INFO - 'MOZ_NO_REMOTE': '1', 09:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:58 INFO - 'NO_EM_RESTART': '1', 09:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:58 INFO - 'PWD': '/builds/slave/test', 09:23:58 INFO - 'SHELL': '/bin/bash', 09:23:58 INFO - 'SHLVL': '1', 09:23:58 INFO - 'TERM': 'linux', 09:23:58 INFO - 'TMOUT': '86400', 09:23:58 INFO - 'USER': 'cltbld', 09:23:58 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:58 INFO - '_': '/tools/buildbot/bin/python'} 09:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:58 INFO - Cleaning up... 09:23:58 INFO - Return code: 0 09:23:58 INFO - Running post-action listener: _resource_record_post_action 09:23:58 INFO - Running post-action listener: _start_resource_monitoring 09:23:58 INFO - Starting resource monitoring. 09:23:58 INFO - [mozharness: 2017-09-25 16:23:58.903809Z] Finished create-virtualenv step (success) 09:23:58 INFO - [mozharness: 2017-09-25 16:23:58.904276Z] Running install step. 09:23:58 INFO - Running pre-action listener: _resource_record_pre_action 09:23:58 INFO - Running main action method: install 09:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:59 INFO - Reading from file tmpfile_stdout 09:23:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:59 INFO - Reading from file tmpfile_stdout 09:23:59 INFO - Output received: 09:23:59 INFO - Usage: mozinstall [options] installer 09:23:59 INFO - Options: 09:23:59 INFO - -h, --help show this help message and exit 09:23:59 INFO - -d DEST, --destination=DEST 09:23:59 INFO - Directory to install application into. [default: 09:23:59 INFO - "/builds/slave/test"] 09:23:59 INFO - --app=APP Application being installed. [default: firefox] 09:23:59 INFO - mkdir: /builds/slave/test/build/application 09:23:59 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'] 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:24:13 INFO - Reading from file tmpfile_stdout 09:24:13 INFO - Output received: 09:24:13 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:13 INFO - Running post-action listener: _resource_record_post_action 09:24:13 INFO - [mozharness: 2017-09-25 16:24:13.808068Z] Finished install step (success) 09:24:13 INFO - [mozharness: 2017-09-25 16:24:13.808407Z] Running setup-mitmproxy step. 09:24:13 INFO - Running pre-action listener: _resource_record_pre_action 09:24:13 INFO - Running main action method: setup_mitmproxy 09:24:13 INFO - Skipping: mitmproxy is not required 09:24:13 INFO - Running post-action listener: _resource_record_post_action 09:24:13 INFO - [mozharness: 2017-09-25 16:24:13.810090Z] Finished setup-mitmproxy step (success) 09:24:13 INFO - [mozharness: 2017-09-25 16:24:13.810403Z] Running run-tests step. 09:24:13 INFO - Running pre-action listener: _resource_record_pre_action 09:24:13 INFO - Running pre-action listener: _set_gcov_prefix 09:24:13 INFO - Running main action method: run_tests 09:24:13 WARNING - Try message not found. 09:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:13 INFO - Python 2.7.3 09:24:13 INFO - Return code: 0 09:24:13 INFO - grabbing minidump binary from tooltool 09:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:13 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 0x186f090>, '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 0x186fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1869f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:13 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 09:24:13 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 09:24:13 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 09:24:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:13 INFO - Return code: 0 09:24:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:13 INFO - ENV: RUST_BACKTRACE is now full 09:24:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 09:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 09:24:13 INFO - Using env: {'DISPLAY': ':0', 09:24:13 INFO - 'HOME': '/home/cltbld', 09:24:13 INFO - 'LANG': 'en_US.UTF-8', 09:24:13 INFO - 'LANGUAGE': 'en_US:en', 09:24:13 INFO - 'LOGNAME': 'cltbld', 09:24:13 INFO - 'MAIL': '/var/mail/cltbld', 09:24:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:13 INFO - 'MOZ_NO_REMOTE': '1', 09:24:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:13 INFO - 'NO_EM_RESTART': '1', 09:24:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:13 INFO - 'PWD': '/builds/slave/test', 09:24:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:13 INFO - 'RUST_BACKTRACE': 'full', 09:24:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:24:13 INFO - 'SHELL': '/bin/bash', 09:24:13 INFO - 'SHLVL': '1', 09:24:13 INFO - 'TERM': 'linux', 09:24:13 INFO - 'TMOUT': '86400', 09:24:13 INFO - 'USER': 'cltbld', 09:24:13 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:13 INFO - '_': '/tools/buildbot/bin/python'} 09:24:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 09:24:14 INFO - mozversion application_buildid: 20170925150345 09:24:14 INFO - mozversion application_changeset: c3f480fa9744b65485b77e5d67768a9dbf075752 09:24:14 INFO - mozversion application_display_name: Firefox 09:24:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:14 INFO - mozversion application_name: Firefox 09:24:14 INFO - mozversion application_remotingname: firefox 09:24:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:24:14 INFO - mozversion application_vendor: Mozilla 09:24:14 INFO - mozversion application_version: 57.0 09:24:14 INFO - mozversion platform_buildid: 20170925150345 09:24:14 INFO - mozversion platform_changeset: c3f480fa9744b65485b77e5d67768a9dbf075752 09:24:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:24:14 INFO - mozversion platform_version: 57.0 09:24:14 INFO - using testdate: 1506356654 09:24:14 INFO - actual date: 1506356654 09:24:14 INFO - starting webserver on 'localhost:45421' 09:24:14 INFO - SUITE-START | Running 2 tests 09:24:14 INFO - TEST-START | dromaeo_css 09:24:14 INFO - Initialising browser for dromaeo_css test... 09:24:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45421/getInfo.html -profile /tmp/tmpC_V2Cj/profile 09:24:14 INFO - TEST-INFO | started process 26275 (/builds/slave/test/build/application/firefox/firefox http://localhost:45421/getInfo.html) 09:24:19 INFO - TEST-INFO | 26275: exit 0 09:24:20 INFO - Browser initialized. 09:24:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:20 INFO - Using env: {'DISPLAY': ':0', 09:24:20 INFO - 'HOME': '/home/cltbld', 09:24:20 INFO - 'JSGC_DISABLE_POISONING': '1', 09:24:20 INFO - 'LANG': 'en_US.UTF-8', 09:24:20 INFO - 'LANGUAGE': 'en_US:en', 09:24:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:24:20 INFO - 'LOGNAME': 'cltbld', 09:24:20 INFO - 'MAIL': '/var/mail/cltbld', 09:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:20 INFO - 'MOZ_CRASHREPORTER': '1', 09:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:24:20 INFO - 'MOZ_NO_REMOTE': '1', 09:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:20 INFO - 'NO_EM_RESTART': '1', 09:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:20 INFO - 'PWD': '/builds/slave/test', 09:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:20 INFO - 'RUST_BACKTRACE': 'full', 09:24:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:24:20 INFO - 'SHELL': '/bin/bash', 09:24:20 INFO - 'SHLVL': '1', 09:24:20 INFO - 'TERM': 'linux', 09:24:20 INFO - 'TMOUT': '86400', 09:24:20 INFO - 'USER': 'cltbld', 09:24:20 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:20 INFO - '_': '/tools/buildbot/bin/python'} 09:24:20 INFO - TEST-INFO | started process 26469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_V2Cj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:20 INFO - PID 26469 | 09:24:20 INFO - PID 26469 | (/builds/slave/test/build/application/firefox/firefox:26517): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:24:20 INFO - PID 26469 | 09:24:31 INFO - PID 26469 | RSS: Main: 141668352 09:24:31 INFO - PID 26469 | 09:27:28 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45421/tests/dromaeo/cssquery-ext.html) 09:27:29 INFO - PID 26469 | RSS: Main: 144928768 09:27:29 INFO - PID 26469 | 09:30:30 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-ext.html (next: http://localhost:45421/tests/dromaeo/cssquery-jquery.html) 09:30:31 INFO - PID 26469 | RSS: Main: 144412672 09:30:31 INFO - PID 26469 | 09:33:33 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45421/tests/dromaeo/cssquery-mootools.html) 09:33:33 INFO - PID 26469 | RSS: Main: 145412096 09:33:33 INFO - PID 26469 | 09:36:35 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45421/tests/dromaeo/cssquery-prototype.html) 09:36:35 INFO - PID 26469 | RSS: Main: 144543744 09:36:35 INFO - PID 26469 | 09:39:38 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45421/tests/dromaeo/cssquery-yui.html) 09:39:39 INFO - PID 26469 | RSS: Main: 145690624 09:39:39 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | Cycle 1(1): loaded http://localhost:45421/tests/dromaeo/cssquery-yui.html (next: http://localhost:45421/tests/dromaeo/cssquery-dojo.html) 09:42:41 INFO - PID 26469 | RSS: Main: 148398080 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | __start_tp_report 09:42:41 INFO - PID 26469 | _x_x_mozilla_page_load 09:42:41 INFO - PID 26469 | _x_x_mozilla_page_load_details 09:42:41 INFO - PID 26469 | |i|pagename|runs| 09:42:41 INFO - PID 26469 | |0;dojo.html;3971.3447281198587;3982.721209515334;3984.681225501959;3998.220347032328;4020.216057868713;6345.302016778156;6349;6368.713407896645;6466.6443345616035;6472.51456140789;6419.101325814389;6432.517561182918;6455.515836312272;6486.708098135583;6521.804345869631;5674.744636491368;5684.062129748597;5782.971085144568;5784.016717158072;5797.333306669724;5679.829605111853;5747.137929310595;5760.0495918173665;5779.306483222019;5843.737031833578;5737.168110623957;5799.652020878761;5814.796482123126;5819.068948968166;5839.328477225131;5679.943200567983;5769.365369809318;5770.307563092456;5828.912566311508;5835.183074369592;5604.859878503029;5622.269105016322;5709.685967271798;5716.828495145152;5717.171010203498;6328.968355158195;6362.681865906686;6408.295087540367;6417.101605775195;6431.967840160816;6950.409215216712;6957.686904089328;6975.511714180009;7048;7092.113485814273;6964.79105626832;7000.159980802286;7088.751893683696;7094.184168820549;7095.680694368766;6506.479481641457;6565.57323773958;6571.507136964651;6578.243501997284;6602.636854972975;7159.856802863914;7183.928160718326;7193.2447093055525;7293.817654558572;7300.269973002657;6919.75780847678;6920.930790692129;6954.860902782018;7003.439724822002;7039.788806335818;6974.232834388214;6989.545679530815;7059.2234854166;7064.894026589605;7121.821954451077;6944.618046007417;6951.304869513109;6969;6999.965000174967;7014.368706816411;6845.520813543104;6936.93063069373;7002.824929376807;7018.052562904045;7023.051887995158;5050.72221027847;5067.493250674903;5121.820736274212;5140;5141.691498510101;4615.607673347803;4670.743109129031;4720.551547602972;4728.4562275338085;4758.095961767253;6542.672866356663;6547.410733034049;6611.834704132435;6623.933760662428;6624.072629831828;6936.445084393236;6942.687579058955;6979.6859141337745;7015.193252775894;7024.613646249403;6494.675266236669;6593.109930159463;6598.571092879043;6617.735290588419;6628.801135965832;5748.856278592985;5808.94191058084;5826.2134611827705;5827.3298570664065;5830.53355731549;7411.481196316314;7415.295546923034;7502.17476077631;7511;7521.623918804038;6874.828129296708;6986.056882320821;7076.150861896605;7076.186238582629;7081.044059052065;7203.927960720326;7338.972543843759;7344.081989751281;7433.293837085468;7442.032535770315;6916.1700595926795;6924.515283930076;6954.965225173842;6995.0906382172025;7003;6936.514443989075;6992;6999.755008574675;7006.684699188447;7065;6714.664266786739;6722.865542689216;6743.595384276763;6745.089412929192;6756.831079223059;6686.899696504654;6694.096297000037;6717.1267735194115;6721.764738234138;6727.024581435762;6654.434373078149;6670.7665231716655;6767.526273161028;6790.219124800514;6799.6600169990315;6771.45828333742;6782.220044694726;6812.863742725217;6856.862862742618;6858.039874417485;6576.309487503934;6607.900881486686;6661.533692641468;6672.266050734318;6675.065490831191 09:42:41 INFO - PID 26469 | |1;ext.html;995.8058178655162;1002.794427142435;1017.1608423050983;1022.6778564752102;1024.5491983527252;47803.282950755725;48912.02175956483;48956.51043489564;48959;48977.7551112244;46390.30414543776;46671;46696;46707.53292467074;46800.29799553001;7971.20287971204;8043;8046.557439340834;8048.678052877878;8049.154838741935;8269.173082691712;8365.247127758501;8369.748907532783;8371.121032291583;8371.246587807096;8326.958365208166;8872.068432814558;9082.409643373192;9083;9085.727428177166;8933.597988090487;8947.776305592348;8988.910110898873;9015.549222538879;9025.41334813235;8729;8898.065703101145;8904.73285801427;8932.776680583038;8933.330000249942;44160;44384.3342349865;44386.11227775426;44402.333964990554;44413;3947.5657677655436;3990.660793832528;3990.860319888819;3991.6207960243732;3992.540857801361;35670.10824729376;35801.82099089488;36001.639983600355;36060;36097.63902360969;5694.715264236772;5711.428857114255;5713.171590119451;5721.828345149652;5814.476697097281;239803;240810;241237;241262;241508.79245603835;51672;52462.475375246526;57063.429365706645;57128.42871571314;57466.13800792991;60013;60067.699661501414;60127;60141.39858601358;60244.397556023876;18770.0614969251;18841;19009;19009.42971710851;19036.048197590342;15693.215339232993;15739;15809.920950395175;15920.124393158487;15977.760333595006;15747.527574172793;15865.762013569805;15882.047077175406;15893.523194304189;15944.441944531885;6121.265448146251;6221.564490485623;6232.844178895473;6287.088372186007;6288.654124023223;1133.0002545507023;1135.3528488761492;1138.8064029115071;1142.5030111901349;1154.203599516331;26652.735562310325;27137.457250854874;27210.72789272082;27320.180394588195;27464.450710985668;1235.8022716365517;1240.1566934484638;1261.7602655495427;1265.4242319744494;1268.898488120948;14252.484247752389;14414.855851441562;14431.061980971414;14437.35031923545;14617.196054216907;276987;279705;279829;280261;280291;63506.68246658737;64126.35873641204;64128.358716413175;64365.35634643594;64587.354126459075;1590.769338445942;1608.1637548474728;1609.5332353617555;1615.2166199393284;1618.7086324461475;26786.33034174083;26900.327491812863;27002.594961075207;27045.59431608567;27336.179914602595;44217.33673994828;44475.999999998705;44488.55511444844;44539.10921781482;44673.32990005217;235541;235677;236627;237766;237778;38217.80891095638;39711.40432893567;40024;40042.39936401015;40058.799706001286;49759;50848.49151508586;51133.23300150426;51326.23010654918;51476.48523514717;36799.26401471902;37139.81430092832;37163.44254836126;37625;37698.62301376951;37245;37274.627253727114;37524.43713344247;37607;38010.61989380181;43608.12783744371;44210;44243.33634995542;44458;44750;36232;36249.27501450009;36408.63591364052;36529.63470365369;36707;26951.865240673673;27001.324966875985;27218.863905680344;27245.318867028484;27584.310392239553 09:42:41 INFO - PID 26469 | |2;jquery.html;647.1982610235175;648.7959748974221;649.4211466527175;651.7990237628973;654.2228241116461;24891.875540622295;25861.965521379145;25938.87030564847;26010;26019.73980260197;27309.180724578295;27576;27640.58539121915;27658.861705691445;27673.86163069182;6251.374862513746;6570;6590.835229119262;6594.967025164868;6605.174353205849;6612.206535215757;6700.430463410616;6702.798916032527;6706.295838936914;6707.993800929851;6665.200175978889;6795.252522222551;7049.259827718092;7055.89416158758;7056.329648683367;6878.380945714885;6928.030075789394;6932.376086152271;6935.68789404473;6939.132608423947;6431.774887878902;6460.353964603549;6470.320616335312;6482.189726284215;6494.318096599836;30725.231869203224;31627.36745265082;32086.35827283441;32110.518342224885;32165.517517237025;2458.397692565315;2490.7633774791366;2499.150288901764;2499.7000359956924;2500.112460076683;19435.12541935616;19521.31675391369;19608.80391196084;19633.901830490755;19640.508987275432;2543.7329080446657;2575.72954839741;2651.7613414792763;2656.4023094803515;2661.1218297961627;150014;156426.21786890994;156968;172109;177104.11447942807;15932.761008584881;17344.306227751;17405.216765245594;17495.47513574569;17656.558586035197;27937.16188514348;27949;27980.580291295646;27998.86000569984;28068.157955261377;11695.76608467843;11963.760724785456;12017;12061.698457538632;12104.697382565506;11054.557817687364;11124.443777811077;11140.721481962853;11159.665210043711;11163.553457861757;10182.745431364276;10198.388096714221;10489.370637761758;10527.578896844041;10528.210384221215;2925.605043319167;2941.7646588272887;2965.9703402966124;3041.9695803042127;3164.5727826743555;1054.836500342448;1092.5575142067476;1103.586155191803;1114.7324642085841;1124.4714983957526;21781.346559603237;21865.453363666034;21900.671489927663;22104.889475552518;22298.442538936655;1163.1567113842395;1171.0572988743972;1180.2859270141612;1183.556166437586;1187.3469591724518;11719.729944479834;11949.044076473861;12004.459799309052;12077.27536347822;12110.152289339661;631687;649129;649741;674979;686401;131248;133768;135902.3204883989;137719.31140344235;138730;1163.1625229834506;1227.7728620205291;1274.26729630461;1283.4160456992233;1339.2500199888093;22039.559208816056;22211.666824997963;22402.215922442636;22417.321341225612;22615.773842262024;62062;62332;62635;63089.369106308346;63940.68029659822;83093.58453207937;83401.58299208707;84259;84714.57642711747;85598;16357.427490037791;16384.262708178398;16406.425775097814;16520.917395412947;16550.50348489547;24527.141550046377;24606.384840379134;24715.258542243762;24870.751292486842;25076.37309067215;19502.512437189183;19735.11191996392;19926;19963.401097967086;20160.09279582393;17766.20052097633;17940;18334.72497912559;18640;18711.71932421042;19735.506612334808;20260.797392025892;20428.080736366603;20699;20744.170233190503;16074.43739469113;16089.919550402174;16157;16162.838371616133;16240.837591624406;19775.40673779789;20190.192392304143;20341.59316813626;20376.28682996088;20480.590388191853 09:42:41 INFO - PID 26469 | |3;mootools.html;1447.833499147598;1505.9548213553594;1514.0915450729572;1519.5973067137204;1525.1992703830488;17401.738973915384;18051.54871128221;18059.187336569852;18060;18074.5481362966;17582.648347033082;17673.381431649894;17675.46973590791;17713.91143044283;17723.025233612145;2963.511020681585;3023.319753055556;3076.2924527358723;3086.27472543952;3092.675269096746;3001.8198908065588;3029.0609910927574;3031.181580973136;3032.2267821705436;3037.9088627341102;2788.4562510310498;2874.8562571871425;2879.3233590106306;3030.681778413268;3036.6963303669677;3032.6664066952617;3044.8173109613494;3086.0433265687707;3086.8302243376606;3086.9382612347854;2902.05683152974;2915.052607902419;2915.1837485504093;2924.239697678619;2938.7795915306438;16974.660506789794;17264.913675431668;17352.045637489933;17388.391406300718;17416.30334786607;8565.614547345385;8824.558772061435;8828.602712877871;8831.425957312755;8844.911550884473;5880.147378630075;5945.821625351246;6082.695865206766;6086.11751296064;6132.141500189977;2136.978630213709;2205.8014778669994;2210.491586934998;2254.695616091823;2256.1088370093885;30039.249018774488;30413.543796843063;30521;30572.8471357644;30572.8471357644;7282.198958114604;7303.561786292839;7697.730579429693;7718.3053525183;7751.34113600339;17824.732629010574;17827.286908523773;17927.910360448113;17952.19215135322;17970.460886173434;8602.096779838026;8849.955750221336;8856.601452934634;8861.069587693199;8865.955670221736;7710.843373493909;8108.554029528433;8110.229528194812;8257.174282571696;8273.255407013397;6066.514678825683;6280.905786413116;6324.71538780756;6442.903356449657;6477.028445733178;1840.9447716568525;1846.22458567402;1889.2915156816193;1898.430470858737;1901.9524511887314;864.3474176996453;984.7636567223815;991.613270824379;997.3616885193481;1018.4805749068029;9844.064813842673;9863.506824658738;9968.900310996942;10114.039166279192;10129.442880641489;836.6653338664461;836.9539675317916;841.3311417423163;850.4047166983013;904.1591320072264;5870.765169393177;6035.305939816977;6085.665288409092;6132.448079672851;6454.483641308684;26130.346741331618;27172.456550868872;27280.181594552196;27528.311792205353;27532;25185;26345.20964371072;27192.184234472996;27265.727342726717;27282.863585681946;12229.877701222875;13407.86592134066;13416.72541108593;13421.39603717835;13431.261280629658;9847.45838978863;10083;10132.49337533135;10251.333663311862;10257.179425645782;21672.34982950514;22173.556528869656;22216.000279987762;22473.43816404603;23447.41381465477;22908.656370154127;23189.3043208704;23327.883360583768;23683.64474532849;24057.398565036015;12782.61652150437;13004.349782510648;13065.804012940003;13125.803112953123;13135.211887286794;16248.350065997227;16563.751543727096;16747.497575072768;16921.323147073977;16927.915360423613;13022.544210952572;13037.087403881636;13162.210267383987;13261.602151935458;13620.114692544952;12803.935980320412;12881.8067728986;12971.870281297066;12976.221426714428;13082;11435.714107147387;11659;11696.122790790554;11706.414679266172;11724.179307448398;8307.626156823078;8317.459365141247;8347.916520834713;8394.45436046655;8428.241458268785;8813.471191728517;8869.955650221966;8875.378723489293;8932.553372331227;8949.910500894908 09:42:41 INFO - PID 26469 | |4;prototype.html;565.9303915599518;605.9545534084943;609.2749627942745;618.9814305570834;620.0760866309199;6352.491800655948;6378.808635740924;6382.20222472191;6429.710663020163;6436.356364363562;6254.655993920333;6287.654179020152;6324.399182077706;6326.240851097863;6329.113924050636;5199.506046925546;5213.035588416136;5216.165413533835;5246.344206974129;5260.263563101169;4891.584215341701;5018.824341148061;5169.3279873616375;5207.64601203686;5239.633225674204;5001.349824522825;5017.974910125445;5041.798328066873;5061.595072394218;5093.516115968977;4962.255661650745;5043.293938848564;5046.873828154307;5063.974680126613;5093.617978651579;4573.153966516205;4580.3358513015755;4615.100055489181;4624.445066591997;4635.304704294349;6241.34465881085;6268.435840774352;6271.184745983039;6273.1531243282025;6325.841853953642;5988.161657367972;5994.220751302347;6066.423689749467;6070.544709146831;6076.05311423959;6664.500162487784;6711.865762684719;6750.696218670171;6787.151606049244;6801.93198068018;5231.869203269911;5237.921431178535;5241.764120614582;5251.291075704769;5271.367435907716;6740.292269311701;6782.253952065269;6895.482838787111;6984.301569843026;7046.964765176142;5328.17413300939;5364.7317634118135;5365.651232669864;5375.086235340002;5397.217403476474;5450.645708029045;5452.863678408072;5462.371827239839;5475.616706830563;5506.146547285177;5986.191864098378;6035.939640603626;6037.426444487766;6037.54718396122;6048.5765996380715;6600.768973085919;6716.328367163244;6725.361090696376;6797.966010169917;6832.350926661959;1868.8504919606398;1870.2705944681586;1871.4759867237196;1873.014604519214;1876.249500199931;1320.4190156331183;1356.8575299593401;1360.1906865415062;1363.2433999130578;1364.8498665146826;6352.936470635327;6365.809025729235;6417.101605775195;6424.807255782334;6433.774817881352;6755.662216889136;6818.761343353058;6864.519483636098;6883.27725588806;6904.965475172692;6368.012957991518;6404.935950640527;6410.358964103552;6427.967860160669;6518.934810651927;3599.4960705501253;3620.1854582719207;3628.4194528875255;3639.381305178073;3655;7198.7840364789145;7262.511185207126;7280.563166210044;7292.854142917112;7340.44946629005;6941.479389045841;6996.790096297119;7000.7549735759;7057.89413158803;7082.645867706594;7001.579905205704;7017.649117544204;7064.15003822928;7067.702996526047;7183.46124040699;6782.084418603426;6850.520463567503;6857.040014398088;6866.244713081657;6927.792166235021;6787.457003439614;6800.251972282946;6851.657417129223;6861.1080559526945;6905.551139175937;7225.927740722525;7230.674619642234;7276.308750668678;7284.94032506338;7319.414446844133;5270.234471451953;5320.2817619620855;5320.680759154463;5370.570354371719;5371.40914499397;6530.9020364693615;6631.3700198481065;6769.255381907888;6784.253732089565;6832.7950161493245;6545.087436091084;6566.146400967844;6617.43751781104;6640.410240006498;6669;6457.257415397289;6486.189226346707;6560.671966401756;6584.275729669636;6599.307072757483;6431.710573024132;6479;6514.902276465951;6610.909199982141;6655.966720166368;6644.435223006099;6659.733610655519;6672.099266599141;6710.664466776544;6762.053312536347;6444;6456.225252969486;6505.772297969737;6528.445082167879;6545.21457425112 09:42:41 INFO - PID 26469 | |5;yui.html;998.6119294181087;1004.5429329655008;1015.9085682288593;1018.4805749067973;1032.0711359776196;20898.373048808542;21069.68395474067;21578.13687452502;21821.890890545565;21859.234926777564;21720.34838954834;22258.332250032527;22828.20101296455;23074.769252307473;23222.071117155294;1107.1087774341652;1136.551062330379;1136.9545218191263;1137.175547727899;1137.9487923043441;1080.1197024425069;1108.3903852880883;1111.6553868300812;1117.0616681987128;1117.6255954255334;1195.1633856300582;1205.3370646144629;1205.843240378754;1206.5837286136268;1206.806910894257;1173.4836671864352;1179.7640471905568;1185.8280549320343;1188.8335633011386;1188.9048876089892;874.5845723281454;874.9650013999433;875.2735229759285;876.8334016536837;878.6090189865513;21864.562708745896;21890.12439502418;22314.665280020814;22419.215327463462;22512.43718907024;23047;23301.650475242885;23569.646455303184;23702.28893133209;23760;18295.817041829676;18313.17590708408;18374.265029398808;18499;18550.628987420176;4059.5737447567876;4093.7953102344763;4102.118044620421;4103.322951712964;4103.610157035077;163519;166108;166670.1666491672;167963;169844;17354.305827767;17491.212895419736;17837.10814459272;17841.46475605734;17853.28586856511;29559.556606650916;34805.30389392198;35766.64233357685;35830.82084589612;35841.46237806435;9111.726648200565;9728.464934428674;10033;10071.69784906454;10081.49592520371;4807.759612019385;4870.366852309177;4871.829485968045;4890.119778439844;4902.240152776325;6326.936730632727;6513.576617519846;6580.078788969548;6580.605163690194;6582.8354291143105;1240.1566934484638;1263.4882872436679;1263.7725209462385;1269.1750362264602;1269.3145701321182;760.1106705154982;775.3254668438382;775.3525805952094;786.9567173805495;792.6155814429997;13348;13620.795688064687;13670.658233544042;14626.195559244345;14635.560933172022;736.6500912066725;747.5925620536821;753.15270320889;762.4700832921177;766.8197973476229;6492.870142597121;6545.14913061299;6612.86774264512;6615.470762339001;6627.900581491282;150144;151937;153122;154060;157332;130511;131488.3425582866;132559.33720331336;132735.33632331775;138058.3097084508;114232.42883785527;114461;116207;117067;117160.41419792846;12120.696982575506;12210.938945305572;12348.691282718004;12441.760483113127;12512.937435312766;54899.451005489434;55782;55833;56171.43828561662;56610.71694641501;70314.29685703077;71261;71508.28491715224;72048.63975680088;72446.63776681083;17982.2807087715;18393.632127357647;18613.906930465262;18746.906265468584;18756.812431875507;18626.534336641693;18846.3403780867;19097.713534297276;19144.521386965436;19231.807681923;18234;18406.90796546062;18417.631647367245;18571.628567428845;19034.52413689669;18327.816721833144;18448.53878652991;18462.630747385247;18673.90663046676;18689.439316819975;17752;17841.286348546433;17886.910565447088;18028.369007085214;18033.72949405786;12781.552645657357;13094.541691040768;13245.403956821774;13389.062765606313;13430.328483575588;14124.43502259898;14186.503472378417;14280.35738391754;14332.426702931765;14339.426422942965 09:42:41 INFO - PID 26469 | __end_tp_report 09:42:41 INFO - PID 26469 | __start_cc_report 09:42:41 INFO - PID 26469 | _x_x_mozilla_cycle_collect,246 09:42:41 INFO - PID 26469 | __end_cc_report 09:42:41 INFO - PID 26469 | __startTimestamp1506357761272__endTimestamp 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | ------- Summary: start ------- 09:42:41 INFO - PID 26469 | Number of tests: 6 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#0] dojo.html Cycles:165 Average:6454.76 Median:6686.90 stddev:776.34 (11.6%) stddev-sans-first:753.88 09:42:41 INFO - PID 26469 | Values: 3971.3 3982.7 3984.7 3998.2 4020.2 6345.3 6349.0 6368.7 6466.6 6472.5 6419.1 6432.5 6455.5 6486.7 6521.8 5674.7 5684.1 5783.0 5784.0 5797.3 5679.8 5747.1 5760.0 5779.3 5843.7 5737.2 5799.7 5814.8 5819.1 5839.3 5679.9 5769.4 5770.3 5828.9 5835.2 5604.9 5622.3 5709.7 5716.8 5717.2 6329.0 6362.7 6408.3 6417.1 6432.0 6950.4 6957.7 6975.5 7048.0 7092.1 6964.8 7000.2 7088.8 7094.2 7095.7 6506.5 6565.6 6571.5 6578.2 6602.6 7159.9 7183.9 7193.2 7293.8 7300.3 6919.8 6920.9 6954.9 7003.4 7039.8 6974.2 6989.5 7059.2 7064.9 7121.8 6944.6 6951.3 6969.0 7000.0 7014.4 6845.5 6936.9 7002.8 7018.1 7023.1 5050.7 5067.5 5121.8 5140.0 5141.7 4615.6 4670.7 4720.6 4728.5 4758.1 6542.7 6547.4 6611.8 6623.9 6624.1 6936.4 6942.7 6979.7 7015.2 7024.6 6494.7 6593.1 6598.6 6617.7 6628.8 5748.9 5808.9 5826.2 5827.3 5830.5 7411.5 7415.3 7502.2 7511.0 7521.6 6874.8 6986.1 7076.2 7076.2 7081.0 7203.9 7339.0 7344.1 7433.3 7442.0 6916.2 6924.5 6955.0 6995.1 7003.0 6936.5 6992.0 6999.8 7006.7 7065.0 6714.7 6722.9 6743.6 6745.1 6756.8 6686.9 6694.1 6717.1 6721.8 6727.0 6654.4 6670.8 6767.5 6790.2 6799.7 6771.5 6782.2 6812.9 6856.9 6858.0 6576.3 6607.9 6661.5 6672.3 6675.1 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#1] ext.html Cycles:180 Average:44808.48 Median:21829.49 stddev:65674.15 (300.9%) stddev-sans-first:65775.99 09:42:41 INFO - PID 26469 | Values: 995.8 1002.8 1017.2 1022.7 1024.5 47803.3 48912.0 48956.5 48959.0 48977.8 46390.3 46671.0 46696.0 46707.5 46800.3 7971.2 8043.0 8046.6 8048.7 8049.2 8269.2 8365.2 8369.7 8371.1 8371.2 8327.0 8872.1 9082.4 9083.0 9085.7 8933.6 8947.8 8988.9 9015.5 9025.4 8729.0 8898.1 8904.7 8932.8 8933.3 44160.0 44384.3 44386.1 44402.3 44413.0 3947.6 3990.7 3990.9 3991.6 3992.5 35670.1 35801.8 36001.6 36060.0 36097.6 5694.7 5711.4 5713.2 5721.8 5814.5 239803.0 240810.0 241237.0 241262.0 241508.8 51672.0 52462.5 57063.4 57128.4 57466.1 60013.0 60067.7 60127.0 60141.4 60244.4 18770.1 18841.0 19009.0 19009.4 19036.0 15693.2 15739.0 15809.9 15920.1 15977.8 15747.5 15865.8 15882.0 15893.5 15944.4 6121.3 6221.6 6232.8 6287.1 6288.7 1133.0 1135.4 1138.8 1142.5 1154.2 26652.7 27137.5 27210.7 27320.2 27464.5 1235.8 1240.2 1261.8 1265.4 1268.9 14252.5 14414.9 14431.1 14437.4 14617.2 276987.0 279705.0 279829.0 280261.0 280291.0 63506.7 64126.4 64128.4 64365.4 64587.4 1590.8 1608.2 1609.5 1615.2 1618.7 26786.3 26900.3 27002.6 27045.6 27336.2 44217.3 44476.0 44488.6 44539.1 44673.3 235541.0 235677.0 236627.0 237766.0 237778.0 38217.8 39711.4 40024.0 40042.4 40058.8 49759.0 50848.5 51133.2 51326.2 51476.5 36799.3 37139.8 37163.4 37625.0 37698.6 37245.0 37274.6 37524.4 37607.0 38010.6 43608.1 44210.0 44243.3 44458.0 44750.0 36232.0 36249.3 36408.6 36529.6 36707.0 26951.9 27001.3 27218.9 27245.3 27584.3 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#2] jquery.html Cycles:180 Average:42357.92 Median:22255.05 stddev:110044.54 (494.5%) stddev-sans-first:110308.68 09:42:41 INFO - PID 26469 | Values: 647.2 648.8 649.4 651.8 654.2 24891.9 25862.0 25938.9 26010.0 26019.7 27309.2 27576.0 27640.6 27658.9 27673.9 6251.4 6570.0 6590.8 6595.0 6605.2 6612.2 6700.4 6702.8 6706.3 6708.0 6665.2 6795.3 7049.3 7055.9 7056.3 6878.4 6928.0 6932.4 6935.7 6939.1 6431.8 6460.4 6470.3 6482.2 6494.3 30725.2 31627.4 32086.4 32110.5 32165.5 2458.4 2490.8 2499.2 2499.7 2500.1 19435.1 19521.3 19608.8 19633.9 19640.5 2543.7 2575.7 2651.8 2656.4 2661.1 150014.0 156426.2 156968.0 172109.0 177104.1 15932.8 17344.3 17405.2 17495.5 17656.6 27937.2 27949.0 27980.6 27998.9 28068.2 11695.8 11963.8 12017.0 12061.7 12104.7 11054.6 11124.4 11140.7 11159.7 11163.6 10182.7 10198.4 10489.4 10527.6 10528.2 2925.6 2941.8 2966.0 3042.0 3164.6 1054.8 1092.6 1103.6 1114.7 1124.5 21781.3 21865.5 21900.7 22104.9 22298.4 1163.2 1171.1 1180.3 1183.6 1187.3 11719.7 11949.0 12004.5 12077.3 12110.2 631687.0 649129.0 649741.0 674979.0 686401.0 131248.0 133768.0 135902.3 137719.3 138730.0 1163.2 1227.8 1274.3 1283.4 1339.3 22039.6 22211.7 22402.2 22417.3 22615.8 62062.0 62332.0 62635.0 63089.4 63940.7 83093.6 83401.6 84259.0 84714.6 85598.0 16357.4 16384.3 16406.4 16520.9 16550.5 24527.1 24606.4 24715.3 24870.8 25076.4 19502.5 19735.1 19926.0 19963.4 20160.1 17766.2 17940.0 18334.7 18640.0 18711.7 19735.5 20260.8 20428.1 20699.0 20744.2 16074.4 16089.9 16157.0 16162.8 16240.8 19775.4 20190.2 20341.6 20376.3 20480.6 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#3] mootools.html Cycles:180 Average:10915.19 Median:27530.16 stddev:7992.80 (29.0%) stddev-sans-first:7983.57 09:42:41 INFO - PID 26469 | Values: 1447.8 1506.0 1514.1 1519.6 1525.2 17401.7 18051.5 18059.2 18060.0 18074.5 17582.6 17673.4 17675.5 17713.9 17723.0 2963.5 3023.3 3076.3 3086.3 3092.7 3001.8 3029.1 3031.2 3032.2 3037.9 2788.5 2874.9 2879.3 3030.7 3036.7 3032.7 3044.8 3086.0 3086.8 3086.9 2902.1 2915.1 2915.2 2924.2 2938.8 16974.7 17264.9 17352.0 17388.4 17416.3 8565.6 8824.6 8828.6 8831.4 8844.9 5880.1 5945.8 6082.7 6086.1 6132.1 2137.0 2205.8 2210.5 2254.7 2256.1 30039.2 30413.5 30521.0 30572.8 30572.8 7282.2 7303.6 7697.7 7718.3 7751.3 17824.7 17827.3 17927.9 17952.2 17970.5 8602.1 8850.0 8856.6 8861.1 8866.0 7710.8 8108.6 8110.2 8257.2 8273.3 6066.5 6280.9 6324.7 6442.9 6477.0 1840.9 1846.2 1889.3 1898.4 1902.0 864.3 984.8 991.6 997.4 1018.5 9844.1 9863.5 9968.9 10114.0 10129.4 836.7 837.0 841.3 850.4 904.2 5870.8 6035.3 6085.7 6132.4 6454.5 26130.3 27172.5 27280.2 27528.3 27532.0 25185.0 26345.2 27192.2 27265.7 27282.9 12229.9 13407.9 13416.7 13421.4 13431.3 9847.5 10083.0 10132.5 10251.3 10257.2 21672.3 22173.6 22216.0 22473.4 23447.4 22908.7 23189.3 23327.9 23683.6 24057.4 12782.6 13004.3 13065.8 13125.8 13135.2 16248.4 16563.8 16747.5 16921.3 16927.9 13022.5 13037.1 13162.2 13261.6 13620.1 12803.9 12881.8 12971.9 12976.2 13082.0 11435.7 11659.0 11696.1 11706.4 11724.2 8307.6 8317.5 8347.9 8394.5 8428.2 8813.5 8870.0 8875.4 8932.6 8949.9 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#4] prototype.html Cycles:180 Average:5746.64 Median:6393.57 stddev:1588.38 (24.8%) stddev-sans-first:1544.51 09:42:41 INFO - PID 26469 | Values: 565.9 606.0 609.3 619.0 620.1 6352.5 6378.8 6382.2 6429.7 6436.4 6254.7 6287.7 6324.4 6326.2 6329.1 5199.5 5213.0 5216.2 5246.3 5260.3 4891.6 5018.8 5169.3 5207.6 5239.6 5001.3 5018.0 5041.8 5061.6 5093.5 4962.3 5043.3 5046.9 5064.0 5093.6 4573.2 4580.3 4615.1 4624.4 4635.3 6241.3 6268.4 6271.2 6273.2 6325.8 5988.2 5994.2 6066.4 6070.5 6076.1 6664.5 6711.9 6750.7 6787.2 6801.9 5231.9 5237.9 5241.8 5251.3 5271.4 6740.3 6782.3 6895.5 6984.3 7047.0 5328.2 5364.7 5365.7 5375.1 5397.2 5450.6 5452.9 5462.4 5475.6 5506.1 5986.2 6035.9 6037.4 6037.5 6048.6 6600.8 6716.3 6725.4 6798.0 6832.4 1868.9 1870.3 1871.5 1873.0 1876.2 1320.4 1356.9 1360.2 1363.2 1364.8 6352.9 6365.8 6417.1 6424.8 6433.8 6755.7 6818.8 6864.5 6883.3 6905.0 6368.0 6404.9 6410.4 6428.0 6518.9 3599.5 3620.2 3628.4 3639.4 3655.0 7198.8 7262.5 7280.6 7292.9 7340.4 6941.5 6996.8 7000.8 7057.9 7082.6 7001.6 7017.6 7064.2 7067.7 7183.5 6782.1 6850.5 6857.0 6866.2 6927.8 6787.5 6800.3 6851.7 6861.1 6905.6 7225.9 7230.7 7276.3 7284.9 7319.4 5270.2 5320.3 5320.7 5370.6 5371.4 6530.9 6631.4 6769.3 6784.3 6832.8 6545.1 6566.1 6617.4 6640.4 6669.0 6457.3 6486.2 6560.7 6584.3 6599.3 6431.7 6479.0 6514.9 6610.9 6656.0 6644.4 6659.7 6672.1 6710.7 6762.1 6444.0 6456.2 6505.8 6528.4 6545.2 09:42:41 INFO - PID 26469 | 09:42:41 INFO - PID 26469 | [#5] yui.html Cycles:180 Average:28999.01 Median:18433.09 stddev:43248.34 (234.6%) stddev-sans-first:43318.56 09:42:41 INFO - PID 26469 | Values: 998.6 1004.5 1015.9 1018.5 1032.1 20898.4 21069.7 21578.1 21821.9 21859.2 21720.3 22258.3 22828.2 23074.8 23222.1 1107.1 1136.6 1137.0 1137.2 1137.9 1080.1 1108.4 1111.7 1117.1 1117.6 1195.2 1205.3 1205.8 1206.6 1206.8 1173.5 1179.8 1185.8 1188.8 1188.9 874.6 875.0 875.3 876.8 878.6 21864.6 21890.1 22314.7 22419.2 22512.4 23047.0 23301.7 23569.6 23702.3 23760.0 18295.8 18313.2 18374.3 18499.0 18550.6 4059.6 4093.8 4102.1 4103.3 4103.6 163519.0 166108.0 166670.2 167963.0 169844.0 17354.3 17491.2 17837.1 17841.5 17853.3 29559.6 34805.3 35766.6 35830.8 35841.5 9111.7 9728.5 10033.0 10071.7 10081.5 4807.8 4870.4 4871.8 4890.1 4902.2 6326.9 6513.6 6580.1 6580.6 6582.8 1240.2 1263.5 1263.8 1269.2 1269.3 760.1 775.3 775.4 787.0 792.6 13348.0 13620.8 13670.7 14626.2 14635.6 736.7 747.6 753.2 762.5 766.8 6492.9 6545.1 6612.9 6615.5 6627.9 150144.0 151937.0 153122.0 154060.0 157332.0 130511.0 131488.3 132559.3 132735.3 138058.3 114232.4 114461.0 116207.0 117067.0 117160.4 12120.7 12210.9 12348.7 12441.8 12512.9 54899.5 55782.0 55833.0 56171.4 56610.7 70314.3 71261.0 71508.3 72048.6 72446.6 17982.3 18393.6 18613.9 18746.9 18756.8 18626.5 18846.3 19097.7 19144.5 19231.8 18234.0 18406.9 18417.6 18571.6 19034.5 18327.8 18448.5 18462.6 18673.9 18689.4 17752.0 17841.3 17886.9 18028.4 18033.7 12781.6 13094.5 13245.4 13389.1 13430.3 14124.4 14186.5 14280.4 14332.4 14339.4 09:42:41 INFO - PID 26469 | -------- Summary: end -------- 09:42:41 INFO - PID 26469 | 09:42:41 INFO - TEST-INFO | 26469: exit 0 09:42:41 INFO - TEST-OK | dromaeo_css | took 1107723ms 09:42:41 INFO - TEST-START | kraken 09:42:41 INFO - Initialising browser for kraken test... 09:42:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45421/getInfo.html -profile /tmp/tmpPHrcgf/profile 09:42:41 INFO - TEST-INFO | started process 26828 (/builds/slave/test/build/application/firefox/firefox http://localhost:45421/getInfo.html) 09:42:47 INFO - TEST-INFO | 26828: exit 0 09:42:47 INFO - Browser initialized. 09:42:47 INFO - Running cycle 1/1 for kraken test... 09:42:47 INFO - Using env: {'DISPLAY': ':0', 09:42:47 INFO - 'HOME': '/home/cltbld', 09:42:47 INFO - 'JSGC_DISABLE_POISONING': '1', 09:42:47 INFO - 'LANG': 'en_US.UTF-8', 09:42:47 INFO - 'LANGUAGE': 'en_US:en', 09:42:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:42:47 INFO - 'LOGNAME': 'cltbld', 09:42:47 INFO - 'MAIL': '/var/mail/cltbld', 09:42:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:42:47 INFO - 'MOZ_CRASHREPORTER': '1', 09:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:42:47 INFO - 'MOZ_NO_REMOTE': '1', 09:42:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:47 INFO - 'NO_EM_RESTART': '1', 09:42:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:47 INFO - 'PWD': '/builds/slave/test', 09:42:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:47 INFO - 'RUST_BACKTRACE': 'full', 09:42:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:42:47 INFO - 'SHELL': '/bin/bash', 09:42:47 INFO - 'SHLVL': '1', 09:42:47 INFO - 'TERM': 'linux', 09:42:47 INFO - 'TMOUT': '86400', 09:42:47 INFO - 'USER': 'cltbld', 09:42:47 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734', 09:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:47 INFO - '_': '/tools/buildbot/bin/python'} 09:42:47 INFO - TEST-INFO | started process 27018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHrcgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:48 INFO - PID 27018 | 09:42:48 INFO - PID 27018 | (/builds/slave/test/build/application/firefox/firefox:27066): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:42:48 INFO - PID 27018 | 09:42:58 INFO - PID 27018 | RSS: Main: 141242368 09:42:58 INFO - PID 27018 | 09:43:01 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45421/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:02 INFO - PID 27018 | RSS: Main: 147529728 09:43:02 INFO - PID 27018 | 09:43:04 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45421/tests/kraken/driver.html?testName=audio-dft) 09:43:05 INFO - PID 27018 | RSS: Main: 147894272 09:43:05 INFO - PID 27018 | 09:43:08 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45421/tests/kraken/driver.html?testName=audio-fft) 09:43:08 INFO - PID 27018 | RSS: Main: 149819392 09:43:08 INFO - PID 27018 | 09:43:10 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45421/tests/kraken/driver.html?testName=audio-oscillator) 09:43:11 INFO - PID 27018 | RSS: Main: 150016000 09:43:11 INFO - PID 27018 | 09:43:13 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:14 INFO - PID 27018 | RSS: Main: 150204416 09:43:14 INFO - PID 27018 | 09:43:17 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45421/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:17 INFO - PID 27018 | RSS: Main: 149786624 09:43:17 INFO - PID 27018 | 09:43:21 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45421/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:21 INFO - PID 27018 | RSS: Main: 150740992 09:43:21 INFO - PID 27018 | 09:43:24 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45421/tests/kraken/driver.html?testName=json-parse-financial) 09:43:25 INFO - PID 27018 | RSS: Main: 151826432 09:43:25 INFO - PID 27018 | 09:43:26 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:27 INFO - PID 27018 | RSS: Main: 151777280 09:43:27 INFO - PID 27018 | 09:43:28 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:29 INFO - PID 27018 | RSS: Main: 152031232 09:43:29 INFO - PID 27018 | 09:43:31 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:32 INFO - PID 27018 | RSS: Main: 149254144 09:43:32 INFO - PID 27018 | 09:43:34 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:35 INFO - PID 27018 | RSS: Main: 149028864 09:43:35 INFO - PID 27018 | 09:43:37 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:38 INFO - PID 27018 | RSS: Main: 149463040 09:43:38 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | Cycle 1(1): loaded http://localhost:45421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45421/tests/kraken/driver.html?testName=ai-astar) 09:43:40 INFO - PID 27018 | RSS: Main: 151064576 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | __start_tp_report 09:43:40 INFO - PID 27018 | _x_x_mozilla_page_load 09:43:40 INFO - PID 27018 | _x_x_mozilla_page_load_details 09:43:40 INFO - PID 27018 | |i|pagename|runs| 09:43:40 INFO - PID 27018 | |0;ai-astar;105;105;106;106;104;106;107;104;105;105 09:43:40 INFO - PID 27018 | |1;audio-beat-detection;110;116;110;116;114;113;118;111;110;113 09:43:40 INFO - PID 27018 | |2;audio-dft;165;163;163;162;163;160;163;161;162;162 09:43:40 INFO - PID 27018 | |3;audio-fft;72;72;74;72;73;72;73;73;79;74 09:43:40 INFO - PID 27018 | |4;audio-oscillator;78;77;83;78;78;130;77;78;78;78 09:43:40 INFO - PID 27018 | |5;imaging-gaussian-blur;114;113;114;113;113;114;114;114;114;113 09:43:40 INFO - PID 27018 | |6;imaging-darkroom;149;148;147;149;148;148;148;149;149;147 09:43:40 INFO - PID 27018 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;95;94 09:43:40 INFO - PID 27018 | |8;json-parse-financial;43;43;42;45;44;46;47;43;42;42 09:43:40 INFO - PID 27018 | |9;json-stringify-tinderbox;36;36;35;35;36;36;36;35;36;36 09:43:40 INFO - PID 27018 | |10;stanford-crypto-aes;71;69;72;72;69;70;73;81;71;69 09:43:40 INFO - PID 27018 | |11;stanford-crypto-ccm;102;100;100;114;104;110;107;108;103;107 09:43:40 INFO - PID 27018 | |12;stanford-crypto-pbkdf2;150;147;150;145;145;148;150;154;150;146 09:43:40 INFO - PID 27018 | |13;stanford-crypto-sha256-iterative;64;59;58;59;62;59;60;60;61;62 09:43:40 INFO - PID 27018 | __end_tp_report 09:43:40 INFO - PID 27018 | __start_cc_report 09:43:40 INFO - PID 27018 | _x_x_mozilla_cycle_collect,648 09:43:40 INFO - PID 27018 | __end_cc_report 09:43:40 INFO - PID 27018 | __startTimestamp1506357820340__endTimestamp 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | ------- Summary: start ------- 09:43:40 INFO - PID 27018 | Number of tests: 14 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.50 stddev:0.95 (0.9%) stddev-sans-first:1.00 09:43:40 INFO - PID 27018 | Values: 105.0 105.0 106.0 106.0 104.0 106.0 107.0 104.0 105.0 105.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#1] audio-beat-detection Cycles:10 Average:113.10 Median:113.50 stddev:2.88 (2.5%) stddev-sans-first:2.83 09:43:40 INFO - PID 27018 | Values: 110.0 116.0 110.0 116.0 114.0 113.0 118.0 111.0 110.0 113.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.05 09:43:40 INFO - PID 27018 | Values: 165.0 163.0 163.0 162.0 163.0 160.0 163.0 161.0 162.0 162.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:2.12 (2.9%) stddev-sans-first:2.19 09:43:40 INFO - PID 27018 | Values: 72.0 72.0 74.0 72.0 73.0 72.0 73.0 73.0 79.0 74.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#4] audio-oscillator Cycles:10 Average:83.50 Median:78.00 stddev:16.43 (21.1%) stddev-sans-first:17.30 09:43:40 INFO - PID 27018 | Values: 78.0 77.0 83.0 78.0 78.0 130.0 77.0 78.0 78.0 78.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:43:40 INFO - PID 27018 | Values: 114.0 113.0 114.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:43:40 INFO - PID 27018 | Values: 149.0 148.0 147.0 149.0 148.0 148.0 148.0 149.0 149.0 147.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:43:40 INFO - PID 27018 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:43.50 stddev:1.77 (4.1%) stddev-sans-first:1.86 09:43:40 INFO - PID 27018 | Values: 43.0 43.0 42.0 45.0 44.0 46.0 47.0 43.0 42.0 42.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#9] json-stringify-tinderbox Cycles:10 Average:35.70 Median:36.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 09:43:40 INFO - PID 27018 | Values: 36.0 36.0 35.0 35.0 36.0 36.0 36.0 35.0 36.0 36.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#10] stanford-crypto-aes Cycles:10 Average:71.70 Median:71.50 stddev:3.56 (5.0%) stddev-sans-first:3.77 09:43:40 INFO - PID 27018 | Values: 71.0 69.0 72.0 72.0 69.0 70.0 73.0 81.0 71.0 69.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#11] stanford-crypto-ccm Cycles:10 Average:105.50 Median:107.00 stddev:4.53 (4.2%) stddev-sans-first:4.62 09:43:40 INFO - PID 27018 | Values: 102.0 100.0 100.0 114.0 104.0 110.0 107.0 108.0 103.0 107.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:150.00 stddev:2.84 (1.9%) stddev-sans-first:2.96 09:43:40 INFO - PID 27018 | Values: 150.0 147.0 150.0 145.0 145.0 148.0 150.0 154.0 150.0 146.0 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:1.84 (3.0%) stddev-sans-first:1.41 09:43:40 INFO - PID 27018 | Values: 64.0 59.0 58.0 59.0 62.0 59.0 60.0 60.0 61.0 62.0 09:43:40 INFO - PID 27018 | -------- Summary: end -------- 09:43:40 INFO - PID 27018 | 09:43:40 INFO - PID 27018 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:43:40 INFO - TEST-INFO | 27018: exit 0 09:43:41 INFO - TEST-OK | kraken | took 59137ms 09:43:41 INFO - SUITE-END | took 1166s 09:43:41 INFO - Completed test suite (00:19:27) 09:43:41 INFO - javascript benchmark 09:43:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9450.922366412273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3971.3447281198587, 3982.721209515334, 3984.681225501959, 3998.220347032328, 4020.216057868713, 6345.302016778156, 6349.0, 6368.713407896645, 6466.6443345616035, 6472.51456140789, 6419.101325814389, 6432.517561182918, 6455.515836312272, 6486.708098135583, 6521.804345869631, 5674.744636491368, 5684.062129748597, 5782.971085144568, 5784.016717158072, 5797.333306669724, 5679.829605111853, 5747.137929310595, 5760.0495918173665, 5779.306483222019, 5843.737031833578, 5737.168110623957, 5799.652020878761, 5814.796482123126, 5819.068948968166, 5839.328477225131, 5679.943200567983, 5769.365369809318, 5770.307563092456, 5828.912566311508, 5835.183074369592, 5604.859878503029, 5622.269105016322, 5709.685967271798, 5716.828495145152, 5717.171010203498, 6328.968355158195, 6362.681865906686, 6408.295087540367, 6417.101605775195, 6431.967840160816, 6950.409215216712, 6957.686904089328, 6975.511714180009, 7048.0, 7092.113485814273, 6964.79105626832, 7000.159980802286, 7088.751893683696, 7094.184168820549, 7095.680694368766, 6506.479481641457, 6565.57323773958, 6571.507136964651, 6578.243501997284, 6602.636854972975, 7159.856802863914, 7183.928160718326, 7193.2447093055525, 7293.817654558572, 7300.269973002657, 6919.75780847678, 6920.930790692129, 6954.860902782018, 7003.439724822002, 7039.788806335818, 6974.232834388214, 6989.545679530815, 7059.2234854166, 7064.894026589605, 7121.821954451077, 6944.618046007417, 6951.304869513109, 6969.0, 6999.965000174967, 7014.368706816411, 6845.520813543104, 6936.93063069373, 7002.824929376807, 7018.052562904045, 7023.051887995158, 5050.72221027847, 5067.493250674903, 5121.820736274212, 5140.0, 5141.691498510101, 4615.607673347803, 4670.743109129031, 4720.551547602972, 4728.4562275338085, 4758.095961767253, 6542.672866356663, 6547.410733034049, 6611.834704132435, 6623.933760662428, 6624.072629831828, 6936.445084393236, 6942.687579058955, 6979.6859141337745, 7015.193252775894, 7024.613646249403, 6494.675266236669, 6593.109930159463, 6598.571092879043, 6617.735290588419, 6628.801135965832, 5748.856278592985, 5808.94191058084, 5826.2134611827705, 5827.3298570664065, 5830.53355731549, 7411.481196316314, 7415.295546923034, 7502.17476077631, 7511.0, 7521.623918804038, 6874.828129296708, 6986.056882320821, 7076.150861896605, 7076.186238582629, 7081.044059052065, 7203.927960720326, 7338.972543843759, 7344.081989751281, 7433.293837085468, 7442.032535770315, 6916.1700595926795, 6924.515283930076, 6954.965225173842, 6995.0906382172025, 7003.0, 6936.514443989075, 6992.0, 6999.755008574675, 7006.684699188447, 7065.0, 6714.664266786739, 6722.865542689216, 6743.595384276763, 6745.089412929192, 6756.831079223059, 6686.899696504654, 6694.096297000037, 6717.1267735194115, 6721.764738234138, 6727.024581435762, 6654.434373078149, 6670.7665231716655, 6767.526273161028, 6790.219124800514, 6799.6600169990315, 6771.45828333742, 6782.220044694726, 6812.863742725217, 6856.862862742618, 6858.039874417485, 6576.309487503934, 6607.900881486686, 6661.533692641468, 6672.266050734318, 6675.065490831191], "value": 6401.62306203845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [995.8058178655162, 1002.794427142435, 1017.1608423050983, 1022.6778564752102, 1024.5491983527252, 47803.282950755725, 48912.02175956483, 48956.51043489564, 48959.0, 48977.7551112244, 46390.30414543776, 46671.0, 46696.0, 46707.53292467074, 46800.29799553001, 7971.20287971204, 8043.0, 8046.557439340834, 8048.678052877878, 8049.154838741935, 8269.173082691712, 8365.247127758501, 8369.748907532783, 8371.121032291583, 8371.246587807096, 8326.958365208166, 8872.068432814558, 9082.409643373192, 9083.0, 9085.727428177166, 8933.597988090487, 8947.776305592348, 8988.910110898873, 9015.549222538879, 9025.41334813235, 8729.0, 8898.065703101145, 8904.73285801427, 8932.776680583038, 8933.330000249942, 44160.0, 44384.3342349865, 44386.11227775426, 44402.333964990554, 44413.0, 3947.5657677655436, 3990.660793832528, 3990.860319888819, 3991.6207960243732, 3992.540857801361, 35670.10824729376, 35801.82099089488, 36001.639983600355, 36060.0, 36097.63902360969, 5694.715264236772, 5711.428857114255, 5713.171590119451, 5721.828345149652, 5814.476697097281, 239803.0, 240810.0, 241237.0, 241262.0, 241508.79245603835, 51672.0, 52462.475375246526, 57063.429365706645, 57128.42871571314, 57466.13800792991, 60013.0, 60067.699661501414, 60127.0, 60141.39858601358, 60244.397556023876, 18770.0614969251, 18841.0, 19009.0, 19009.42971710851, 19036.048197590342, 15693.215339232993, 15739.0, 15809.920950395175, 15920.124393158487, 15977.760333595006, 15747.527574172793, 15865.762013569805, 15882.047077175406, 15893.523194304189, 15944.441944531885, 6121.265448146251, 6221.564490485623, 6232.844178895473, 6287.088372186007, 6288.654124023223, 1133.0002545507023, 1135.3528488761492, 1138.8064029115071, 1142.5030111901349, 1154.203599516331, 26652.735562310325, 27137.457250854874, 27210.72789272082, 27320.180394588195, 27464.450710985668, 1235.8022716365517, 1240.1566934484638, 1261.7602655495427, 1265.4242319744494, 1268.898488120948, 14252.484247752389, 14414.855851441562, 14431.061980971414, 14437.35031923545, 14617.196054216907, 276987.0, 279705.0, 279829.0, 280261.0, 280291.0, 63506.68246658737, 64126.35873641204, 64128.358716413175, 64365.35634643594, 64587.354126459075, 1590.769338445942, 1608.1637548474728, 1609.5332353617555, 1615.2166199393284, 1618.7086324461475, 26786.33034174083, 26900.327491812863, 27002.594961075207, 27045.59431608567, 27336.179914602595, 44217.33673994828, 44475.999999998705, 44488.55511444844, 44539.10921781482, 44673.32990005217, 235541.0, 235677.0, 236627.0, 237766.0, 237778.0, 38217.80891095638, 39711.40432893567, 40024.0, 40042.39936401015, 40058.799706001286, 49759.0, 50848.49151508586, 51133.23300150426, 51326.23010654918, 51476.48523514717, 36799.26401471902, 37139.81430092832, 37163.44254836126, 37625.0, 37698.62301376951, 37245.0, 37274.627253727114, 37524.43713344247, 37607.0, 38010.61989380181, 43608.12783744371, 44210.0, 44243.33634995542, 44458.0, 44750.0, 36232.0, 36249.27501450009, 36408.63591364052, 36529.63470365369, 36707.0, 26951.865240673673, 27001.324966875985, 27218.863905680344, 27245.318867028484, 27584.310392239553], "value": 19864.091694723138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.1982610235175, 648.7959748974221, 649.4211466527175, 651.7990237628973, 654.2228241116461, 24891.875540622295, 25861.965521379145, 25938.87030564847, 26010.0, 26019.73980260197, 27309.180724578295, 27576.0, 27640.58539121915, 27658.861705691445, 27673.86163069182, 6251.374862513746, 6570.0, 6590.835229119262, 6594.967025164868, 6605.174353205849, 6612.206535215757, 6700.430463410616, 6702.798916032527, 6706.295838936914, 6707.993800929851, 6665.200175978889, 6795.252522222551, 7049.259827718092, 7055.89416158758, 7056.329648683367, 6878.380945714885, 6928.030075789394, 6932.376086152271, 6935.68789404473, 6939.132608423947, 6431.774887878902, 6460.353964603549, 6470.320616335312, 6482.189726284215, 6494.318096599836, 30725.231869203224, 31627.36745265082, 32086.35827283441, 32110.518342224885, 32165.517517237025, 2458.397692565315, 2490.7633774791366, 2499.150288901764, 2499.7000359956924, 2500.112460076683, 19435.12541935616, 19521.31675391369, 19608.80391196084, 19633.901830490755, 19640.508987275432, 2543.7329080446657, 2575.72954839741, 2651.7613414792763, 2656.4023094803515, 2661.1218297961627, 150014.0, 156426.21786890994, 156968.0, 172109.0, 177104.11447942807, 15932.761008584881, 17344.306227751, 17405.216765245594, 17495.47513574569, 17656.558586035197, 27937.16188514348, 27949.0, 27980.580291295646, 27998.86000569984, 28068.157955261377, 11695.76608467843, 11963.760724785456, 12017.0, 12061.698457538632, 12104.697382565506, 11054.557817687364, 11124.443777811077, 11140.721481962853, 11159.665210043711, 11163.553457861757, 10182.745431364276, 10198.388096714221, 10489.370637761758, 10527.578896844041, 10528.210384221215, 2925.605043319167, 2941.7646588272887, 2965.9703402966124, 3041.9695803042127, 3164.5727826743555, 1054.836500342448, 1092.5575142067476, 1103.586155191803, 1114.7324642085841, 1124.4714983957526, 21781.346559603237, 21865.453363666034, 21900.671489927663, 22104.889475552518, 22298.442538936655, 1163.1567113842395, 1171.0572988743972, 1180.2859270141612, 1183.556166437586, 1187.3469591724518, 11719.729944479834, 11949.044076473861, 12004.459799309052, 12077.27536347822, 12110.152289339661, 631687.0, 649129.0, 649741.0, 674979.0, 686401.0, 131248.0, 133768.0, 135902.3204883989, 137719.31140344235, 138730.0, 1163.1625229834506, 1227.7728620205291, 1274.26729630461, 1283.4160456992233, 1339.2500199888093, 22039.559208816056, 22211.666824997963, 22402.215922442636, 22417.321341225612, 22615.773842262024, 62062.0, 62332.0, 62635.0, 63089.369106308346, 63940.68029659822, 83093.58453207937, 83401.58299208707, 84259.0, 84714.57642711747, 85598.0, 16357.427490037791, 16384.262708178398, 16406.425775097814, 16520.917395412947, 16550.50348489547, 24527.141550046377, 24606.384840379134, 24715.258542243762, 24870.751292486842, 25076.37309067215, 19502.512437189183, 19735.11191996392, 19926.0, 19963.401097967086, 20160.09279582393, 17766.20052097633, 17940.0, 18334.72497912559, 18640.0, 18711.71932421042, 19735.506612334808, 20260.797392025892, 20428.080736366603, 20699.0, 20744.170233190503, 16074.43739469113, 16089.919550402174, 16157.0, 16162.838371616133, 16240.837591624406, 19775.40673779789, 20190.192392304143, 20341.59316813626, 20376.28682996088, 20480.590388191853], "value": 13389.093565733678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.833499147598, 1505.9548213553594, 1514.0915450729572, 1519.5973067137204, 1525.1992703830488, 17401.738973915384, 18051.54871128221, 18059.187336569852, 18060.0, 18074.5481362966, 17582.648347033082, 17673.381431649894, 17675.46973590791, 17713.91143044283, 17723.025233612145, 2963.511020681585, 3023.319753055556, 3076.2924527358723, 3086.27472543952, 3092.675269096746, 3001.8198908065588, 3029.0609910927574, 3031.181580973136, 3032.2267821705436, 3037.9088627341102, 2788.4562510310498, 2874.8562571871425, 2879.3233590106306, 3030.681778413268, 3036.6963303669677, 3032.6664066952617, 3044.8173109613494, 3086.0433265687707, 3086.8302243376606, 3086.9382612347854, 2902.05683152974, 2915.052607902419, 2915.1837485504093, 2924.239697678619, 2938.7795915306438, 16974.660506789794, 17264.913675431668, 17352.045637489933, 17388.391406300718, 17416.30334786607, 8565.614547345385, 8824.558772061435, 8828.602712877871, 8831.425957312755, 8844.911550884473, 5880.147378630075, 5945.821625351246, 6082.695865206766, 6086.11751296064, 6132.141500189977, 2136.978630213709, 2205.8014778669994, 2210.491586934998, 2254.695616091823, 2256.1088370093885, 30039.249018774488, 30413.543796843063, 30521.0, 30572.8471357644, 30572.8471357644, 7282.198958114604, 7303.561786292839, 7697.730579429693, 7718.3053525183, 7751.34113600339, 17824.732629010574, 17827.286908523773, 17927.910360448113, 17952.19215135322, 17970.460886173434, 8602.096779838026, 8849.955750221336, 8856.601452934634, 8861.069587693199, 8865.955670221736, 7710.843373493909, 8108.554029528433, 8110.229528194812, 8257.174282571696, 8273.255407013397, 6066.514678825683, 6280.905786413116, 6324.71538780756, 6442.903356449657, 6477.028445733178, 1840.9447716568525, 1846.22458567402, 1889.2915156816193, 1898.430470858737, 1901.9524511887314, 864.3474176996453, 984.7636567223815, 991.613270824379, 997.3616885193481, 1018.4805749068029, 9844.064813842673, 9863.506824658738, 9968.900310996942, 10114.039166279192, 10129.442880641489, 836.6653338664461, 836.9539675317916, 841.3311417423163, 850.4047166983013, 904.1591320072264, 5870.765169393177, 6035.305939816977, 6085.665288409092, 6132.448079672851, 6454.483641308684, 26130.346741331618, 27172.456550868872, 27280.181594552196, 27528.311792205353, 27532.0, 25185.0, 26345.20964371072, 27192.184234472996, 27265.727342726717, 27282.863585681946, 12229.877701222875, 13407.86592134066, 13416.72541108593, 13421.39603717835, 13431.261280629658, 9847.45838978863, 10083.0, 10132.49337533135, 10251.333663311862, 10257.179425645782, 21672.34982950514, 22173.556528869656, 22216.000279987762, 22473.43816404603, 23447.41381465477, 22908.656370154127, 23189.3043208704, 23327.883360583768, 23683.64474532849, 24057.398565036015, 12782.61652150437, 13004.349782510648, 13065.804012940003, 13125.803112953123, 13135.211887286794, 16248.350065997227, 16563.751543727096, 16747.497575072768, 16921.323147073977, 16927.915360423613, 13022.544210952572, 13037.087403881636, 13162.210267383987, 13261.602151935458, 13620.114692544952, 12803.935980320412, 12881.8067728986, 12971.870281297066, 12976.221426714428, 13082.0, 11435.714107147387, 11659.0, 11696.122790790554, 11706.414679266172, 11724.179307448398, 8307.626156823078, 8317.459365141247, 8347.916520834713, 8394.45436046655, 8428.241458268785, 8813.471191728517, 8869.955650221966, 8875.378723489293, 8932.553372331227, 8949.910500894908], "value": 7656.102897032205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9303915599518, 605.9545534084943, 609.2749627942745, 618.9814305570834, 620.0760866309199, 6352.491800655948, 6378.808635740924, 6382.20222472191, 6429.710663020163, 6436.356364363562, 6254.655993920333, 6287.654179020152, 6324.399182077706, 6326.240851097863, 6329.113924050636, 5199.506046925546, 5213.035588416136, 5216.165413533835, 5246.344206974129, 5260.263563101169, 4891.584215341701, 5018.824341148061, 5169.3279873616375, 5207.64601203686, 5239.633225674204, 5001.349824522825, 5017.974910125445, 5041.798328066873, 5061.595072394218, 5093.516115968977, 4962.255661650745, 5043.293938848564, 5046.873828154307, 5063.974680126613, 5093.617978651579, 4573.153966516205, 4580.3358513015755, 4615.100055489181, 4624.445066591997, 4635.304704294349, 6241.34465881085, 6268.435840774352, 6271.184745983039, 6273.1531243282025, 6325.841853953642, 5988.161657367972, 5994.220751302347, 6066.423689749467, 6070.544709146831, 6076.05311423959, 6664.500162487784, 6711.865762684719, 6750.696218670171, 6787.151606049244, 6801.93198068018, 5231.869203269911, 5237.921431178535, 5241.764120614582, 5251.291075704769, 5271.367435907716, 6740.292269311701, 6782.253952065269, 6895.482838787111, 6984.301569843026, 7046.964765176142, 5328.17413300939, 5364.7317634118135, 5365.651232669864, 5375.086235340002, 5397.217403476474, 5450.645708029045, 5452.863678408072, 5462.371827239839, 5475.616706830563, 5506.146547285177, 5986.191864098378, 6035.939640603626, 6037.426444487766, 6037.54718396122, 6048.5765996380715, 6600.768973085919, 6716.328367163244, 6725.361090696376, 6797.966010169917, 6832.350926661959, 1868.8504919606398, 1870.2705944681586, 1871.4759867237196, 1873.014604519214, 1876.249500199931, 1320.4190156331183, 1356.8575299593401, 1360.1906865415062, 1363.2433999130578, 1364.8498665146826, 6352.936470635327, 6365.809025729235, 6417.101605775195, 6424.807255782334, 6433.774817881352, 6755.662216889136, 6818.761343353058, 6864.519483636098, 6883.27725588806, 6904.965475172692, 6368.012957991518, 6404.935950640527, 6410.358964103552, 6427.967860160669, 6518.934810651927, 3599.4960705501253, 3620.1854582719207, 3628.4194528875255, 3639.381305178073, 3655.0, 7198.7840364789145, 7262.511185207126, 7280.563166210044, 7292.854142917112, 7340.44946629005, 6941.479389045841, 6996.790096297119, 7000.7549735759, 7057.89413158803, 7082.645867706594, 7001.579905205704, 7017.649117544204, 7064.15003822928, 7067.702996526047, 7183.46124040699, 6782.084418603426, 6850.520463567503, 6857.040014398088, 6866.244713081657, 6927.792166235021, 6787.457003439614, 6800.251972282946, 6851.657417129223, 6861.1080559526945, 6905.551139175937, 7225.927740722525, 7230.674619642234, 7276.308750668678, 7284.94032506338, 7319.414446844133, 5270.234471451953, 5320.2817619620855, 5320.680759154463, 5370.570354371719, 5371.40914499397, 6530.9020364693615, 6631.3700198481065, 6769.255381907888, 6784.253732089565, 6832.7950161493245, 6545.087436091084, 6566.146400967844, 6617.43751781104, 6640.410240006498, 6669.0, 6457.257415397289, 6486.189226346707, 6560.671966401756, 6584.275729669636, 6599.307072757483, 6431.710573024132, 6479.0, 6514.902276465951, 6610.909199982141, 6655.966720166368, 6644.435223006099, 6659.733610655519, 6672.099266599141, 6710.664466776544, 6762.053312536347, 6444.0, 6456.225252969486, 6505.772297969737, 6528.445082167879, 6545.21457425112], "value": 5298.357943045103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [998.6119294181087, 1004.5429329655008, 1015.9085682288593, 1018.4805749067973, 1032.0711359776196, 20898.373048808542, 21069.68395474067, 21578.13687452502, 21821.890890545565, 21859.234926777564, 21720.34838954834, 22258.332250032527, 22828.20101296455, 23074.769252307473, 23222.071117155294, 1107.1087774341652, 1136.551062330379, 1136.9545218191263, 1137.175547727899, 1137.9487923043441, 1080.1197024425069, 1108.3903852880883, 1111.6553868300812, 1117.0616681987128, 1117.6255954255334, 1195.1633856300582, 1205.3370646144629, 1205.843240378754, 1206.5837286136268, 1206.806910894257, 1173.4836671864352, 1179.7640471905568, 1185.8280549320343, 1188.8335633011386, 1188.9048876089892, 874.5845723281454, 874.9650013999433, 875.2735229759285, 876.8334016536837, 878.6090189865513, 21864.562708745896, 21890.12439502418, 22314.665280020814, 22419.215327463462, 22512.43718907024, 23047.0, 23301.650475242885, 23569.646455303184, 23702.28893133209, 23760.0, 18295.817041829676, 18313.17590708408, 18374.265029398808, 18499.0, 18550.628987420176, 4059.5737447567876, 4093.7953102344763, 4102.118044620421, 4103.322951712964, 4103.610157035077, 163519.0, 166108.0, 166670.1666491672, 167963.0, 169844.0, 17354.305827767, 17491.212895419736, 17837.10814459272, 17841.46475605734, 17853.28586856511, 29559.556606650916, 34805.30389392198, 35766.64233357685, 35830.82084589612, 35841.46237806435, 9111.726648200565, 9728.464934428674, 10033.0, 10071.69784906454, 10081.49592520371, 4807.759612019385, 4870.366852309177, 4871.829485968045, 4890.119778439844, 4902.240152776325, 6326.936730632727, 6513.576617519846, 6580.078788969548, 6580.605163690194, 6582.8354291143105, 1240.1566934484638, 1263.4882872436679, 1263.7725209462385, 1269.1750362264602, 1269.3145701321182, 760.1106705154982, 775.3254668438382, 775.3525805952094, 786.9567173805495, 792.6155814429997, 13348.0, 13620.795688064687, 13670.658233544042, 14626.195559244345, 14635.560933172022, 736.6500912066725, 747.5925620536821, 753.15270320889, 762.4700832921177, 766.8197973476229, 6492.870142597121, 6545.14913061299, 6612.86774264512, 6615.470762339001, 6627.900581491282, 150144.0, 151937.0, 153122.0, 154060.0, 157332.0, 130511.0, 131488.3425582866, 132559.33720331336, 132735.33632331775, 138058.3097084508, 114232.42883785527, 114461.0, 116207.0, 117067.0, 117160.41419792846, 12120.696982575506, 12210.938945305572, 12348.691282718004, 12441.760483113127, 12512.937435312766, 54899.451005489434, 55782.0, 55833.0, 56171.43828561662, 56610.71694641501, 70314.29685703077, 71261.0, 71508.28491715224, 72048.63975680088, 72446.63776681083, 17982.2807087715, 18393.632127357647, 18613.906930465262, 18746.906265468584, 18756.812431875507, 18626.534336641693, 18846.3403780867, 19097.713534297276, 19144.521386965436, 19231.807681923, 18234.0, 18406.90796546062, 18417.631647367245, 18571.628567428845, 19034.52413689669, 18327.816721833144, 18448.53878652991, 18462.630747385247, 18673.90663046676, 18689.439316819975, 17752.0, 17841.286348546433, 17886.910565447088, 18028.369007085214, 18033.72949405786, 12781.552645657357, 13094.541691040768, 13245.403956821774, 13389.062765606313, 13430.328483575588, 14124.43502259898, 14186.503472378417, 14280.35738391754, 14332.426702931765, 14339.426422942965], "value": 10317.13051371401, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1359.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 106.0, 104.0, 106.0, 107.0, 104.0, 105.0, 105.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 116.0, 110.0, 116.0, 114.0, 113.0, 118.0, 111.0, 110.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 163.0, 160.0, 163.0, 161.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 72.0, 73.0, 72.0, 73.0, 73.0, 79.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 83.0, 78.0, 78.0, 130.0, 77.0, 78.0, 78.0, 78.0], "value": 83.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 42.0, 45.0, 44.0, 46.0, 47.0, 43.0, 42.0, 42.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 35.0, 35.0, 36.0, 36.0, 36.0, 35.0, 36.0, 36.0], "value": 35.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 72.0, 72.0, 69.0, 70.0, 73.0, 81.0, 71.0, 69.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 100.0, 100.0, 114.0, 104.0, 110.0, 107.0, 108.0, 103.0, 107.0], "value": 105.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 150.0, 145.0, 145.0, 148.0, 150.0, 154.0, 150.0, 146.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 59.0, 58.0, 59.0, 62.0, 59.0, 60.0, 60.0, 61.0, 62.0], "value": 60.4, "unit": "score"}]}]} 09:43:41 INFO - Return code: 0 09:43:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:41 INFO - # TBPL SUCCESS # 09:43:41 INFO - Running post-action listener: _package_coverage_data 09:43:41 INFO - Running post-action listener: _resource_record_post_action 09:43:41 INFO - [mozharness: 2017-09-25 16:43:41.627060Z] Finished run-tests step (success) 09:43:41 INFO - Running post-run listener: _resource_record_post_run 09:43:41 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288030720; Read time: 0; Write time: 145492 09:43:41 INFO - TinderboxPrint: CPU usage
13.0% 09:43:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:43:41 INFO - TinderboxPrint: I/O write bytes / time
288,030,720 / 145,492 09:43:41 INFO - TinderboxPrint: CPU idle
8,194.9 (86.9%) 09:43:41 INFO - TinderboxPrint: CPU user
1,179.1 (12.5%) 09:43:41 INFO - TinderboxPrint: Swap in / out
0 / 0 09:43:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9129984; Read time: 0; Write time: 1304 09:43:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:43:41 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 278900736; Read time: 0; Write time: 144188 09:43:42 INFO - Running post-run listener: _upload_blobber_files 09:43:42 INFO - Blob upload gear active. 09:43:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:42 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 09:43:42 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:43:42 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:43:42 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:43:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:43:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:43 INFO - (blobuploader) - INFO - Done attempting. 09:43:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:44 INFO - (blobuploader) - INFO - Done attempting. 09:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:51 INFO - (blobuploader) - INFO - Done attempting. 09:43:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:52 INFO - (blobuploader) - INFO - Done attempting. 09:43:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:52 INFO - Return code: 0 09:43:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/520a6484a04c60e46a02ea21f5ac59e41871ecf3c2007ac7ed9c8d9022121ec5bc56c108fccc3b2498fc77e1c2fde19aede17685dc812779e3df262d529c49b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/46fb12e586936ce76b4870a134e04291728ce1532d8e5225b0df50bdc08be64146d09624e172de0eb40422834bd00e33ce18cf98449f73e650b4b34b2ea88263", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/649fbdaf6035669960f1e6b9a2e38a313d5592cbb8aacd2a22eba03b16bca5fec54f92187a4a9edb91ce5652147b7e73581ec709dccbe7f585773a16ca476a55", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13a2a20f808566d01b89ca88266b36c8543d11e26bf00d9d25cf2d46741451f371edfe8c4e8df5d017d818f93361335d553b0a77ced190eb92e45bd28804b4b1"} 09:43:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:52 INFO - Contents: 09:43:52 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/520a6484a04c60e46a02ea21f5ac59e41871ecf3c2007ac7ed9c8d9022121ec5bc56c108fccc3b2498fc77e1c2fde19aede17685dc812779e3df262d529c49b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/46fb12e586936ce76b4870a134e04291728ce1532d8e5225b0df50bdc08be64146d09624e172de0eb40422834bd00e33ce18cf98449f73e650b4b34b2ea88263", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/649fbdaf6035669960f1e6b9a2e38a313d5592cbb8aacd2a22eba03b16bca5fec54f92187a4a9edb91ce5652147b7e73581ec709dccbe7f585773a16ca476a55", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13a2a20f808566d01b89ca88266b36c8543d11e26bf00d9d25cf2d46741451f371edfe8c4e8df5d017d818f93361335d553b0a77ced190eb92e45bd28804b4b1"} 09:43:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:52 INFO - Copying logs to upload dir... 09:43:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.636560 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-09-25 09:43:52.424535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 09:43:52.431598) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/520a6484a04c60e46a02ea21f5ac59e41871ecf3c2007ac7ed9c8d9022121ec5bc56c108fccc3b2498fc77e1c2fde19aede17685dc812779e3df262d529c49b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/46fb12e586936ce76b4870a134e04291728ce1532d8e5225b0df50bdc08be64146d09624e172de0eb40422834bd00e33ce18cf98449f73e650b4b34b2ea88263", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/649fbdaf6035669960f1e6b9a2e38a313d5592cbb8aacd2a22eba03b16bca5fec54f92187a4a9edb91ce5652147b7e73581ec709dccbe7f585773a16ca476a55", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13a2a20f808566d01b89ca88266b36c8543d11e26bf00d9d25cf2d46741451f371edfe8c4e8df5d017d818f93361335d553b0a77ced190eb92e45bd28804b4b1"} build_url:https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/L2rPmNg3Rf2OevR9h6zgOw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/520a6484a04c60e46a02ea21f5ac59e41871ecf3c2007ac7ed9c8d9022121ec5bc56c108fccc3b2498fc77e1c2fde19aede17685dc812779e3df262d529c49b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/46fb12e586936ce76b4870a134e04291728ce1532d8e5225b0df50bdc08be64146d09624e172de0eb40422834bd00e33ce18cf98449f73e650b4b34b2ea88263", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/649fbdaf6035669960f1e6b9a2e38a313d5592cbb8aacd2a22eba03b16bca5fec54f92187a4a9edb91ce5652147b7e73581ec709dccbe7f585773a16ca476a55", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13a2a20f808566d01b89ca88266b36c8543d11e26bf00d9d25cf2d46741451f371edfe8c4e8df5d017d818f93361335d553b0a77ced190eb92e45bd28804b4b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 09:43:52.459626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:43:52.459928) ========= 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=fcadb68e09dcf59683000ff6000001dc-1506356598.164480-902464734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 09:43:52.545102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 09:43:52.546472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 09:43:52.546778) ========= ========= Total master_lag: 0.22 =========