builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1505507237.83 results: success (0) revision: 6be5c7d30d2def62a762ac187252eba626b23a92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.828706) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.829121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.829386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.846564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.846842) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 13:27:18-- 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% 109M=0s 2017-09-15 13:27:18 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.973406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:17.973704) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017944 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.026544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.029882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6be5c7d30d2def62a762ac187252eba626b23a92 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 6be5c7d30d2def62a762ac187252eba626b23a92 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 13:27:18,361 truncating revision to first 12 chars 2017-09-15 13:27:18,361 Setting DEBUG logging. 2017-09-15 13:27:18,361 attempt 1/10 2017-09-15 13:27:18,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6be5c7d30d2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 13:27:18,732 unpacking tar archive at: mozilla-central-6be5c7d30d2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.688263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.737279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.737602) ========= script_repo_revision: 6be5c7d30d2def62a762ac187252eba626b23a92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.737987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.738243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:27:18.751889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-15 13:27:18.752215) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:27:19 INFO - MultiFileLogger online at 20170915 13:27:19 in /builds/slave/test 13:27:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:27:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:27:19 INFO - {'append_to_log': False, 13:27:19 INFO - 'base_work_dir': '/builds/slave/test', 13:27:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:27:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:27:19 INFO - 'branch': 'Firefox-Non-PGO', 13:27:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:27:19 INFO - 'code_coverage': False, 13:27:19 INFO - 'config_files': ('talos/linux_config.py',), 13:27:19 INFO - 'default_actions': ('clobber', 13:27:19 INFO - 'read-buildbot-config', 13:27:19 INFO - 'download-and-extract', 13:27:19 INFO - 'populate-webroot', 13:27:19 INFO - 'create-virtualenv', 13:27:19 INFO - 'install', 13:27:19 INFO - 'setup-mitmproxy', 13:27:19 INFO - 'run-tests'), 13:27:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:27:19 INFO - 'disable_ccov_upload': False, 13:27:19 INFO - 'disable_stylo': False, 13:27:19 INFO - 'download_minidump_stackwalk': True, 13:27:19 INFO - 'download_symbols': 'ondemand', 13:27:19 INFO - 'enable_stylo': False, 13:27:19 INFO - 'enable_webrender': False, 13:27:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:27:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:27:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:27:19 INFO - 'gecko_profile': False, 13:27:19 INFO - 'gecko_profile_interval': 0, 13:27:19 INFO - 'installer_path': 'installer.exe', 13:27:19 INFO - 'log_level': 'info', 13:27:19 INFO - 'log_name': 'talos', 13:27:19 INFO - 'log_to_console': True, 13:27:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:27:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:27:19 INFO - 'opt_config_files': (), 13:27:19 INFO - 'pip_index': False, 13:27:19 INFO - 'suite': 'dromaeojs-e10s', 13:27:19 INFO - 'system_bits': '32', 13:27:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:27:19 INFO - 'title': 'talos-linux64-ix-041', 13:27:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:27:19 INFO - 'use_talos_json': True, 13:27:19 INFO - 'verify': 'False', 13:27:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:27:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:27:19 INFO - 'work_dir': 'build'} 13:27:19 INFO - [mozharness: 2017-09-15 20:27:19.226322Z] Running clobber step. 13:27:19 INFO - Running pre-action listener: _resource_record_pre_action 13:27:19 INFO - Running main action method: clobber 13:27:19 INFO - rmtree: /builds/slave/test/build 13:27:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:27:20 INFO - Running post-action listener: _resource_record_post_action 13:27:20 INFO - [mozharness: 2017-09-15 20:27:20.821923Z] Finished clobber step (success) 13:27:20 INFO - [mozharness: 2017-09-15 20:27:20.822020Z] Running read-buildbot-config step. 13:27:20 INFO - Running pre-action listener: _resource_record_pre_action 13:27:20 INFO - Running main action method: read_buildbot_config 13:27:20 INFO - Using buildbot properties: 13:27:20 INFO - { 13:27:20 INFO - "project": "", 13:27:20 INFO - "product": "firefox", 13:27:20 INFO - "who": "archaeopteryx@coole-files.de", 13:27:20 INFO - "installer_path": "public/build/target.tar.bz2", 13:27:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:27:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:27:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:27:20 INFO - "stage_platform": "linux64", 13:27:20 INFO - "basedir": "/builds/slave/test", 13:27:20 INFO - "buildnumber": 831, 13:27:20 INFO - "platform": "ubuntu64_hw", 13:27:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:27:20 INFO - "slavebuilddir": "test", 13:27:20 INFO - "taskId": "dX8-PB5zQ9WOMBM1Tt0N7g", 13:27:20 INFO - "branch": "mozilla-central", 13:27:20 INFO - "script_repo_revision": "production", 13:27:20 INFO - "revision": "6be5c7d30d2def62a762ac187252eba626b23a92", 13:27:20 INFO - "slavename": "talos-linux64-ix-041", 13:27:20 INFO - "repo_path": "mozilla-central" 13:27:20 INFO - } 13:27:20 INFO - Finding installer, test and symbols from parent task. 13:27:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dX8-PB5zQ9WOMBM1Tt0N7g'}, attempt #1 13:27:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dX8-PB5zQ9WOMBM1Tt0N7g'}, attempt #1 13:27:21 INFO - Task dependencies: HEC1C_ZMRHqFUdBa7PZcFg 13:27:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg'}, attempt #1 13:27:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 13:27:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.test_packages.json 13:27:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.crashreporter-symbols.zip 13:27:22 INFO - Running post-action listener: _resource_record_post_action 13:27:22 INFO - [mozharness: 2017-09-15 20:27:22.279323Z] Finished read-buildbot-config step (success) 13:27:22 INFO - [mozharness: 2017-09-15 20:27:22.279540Z] Running download-and-extract step. 13:27:22 INFO - Running pre-action listener: _resource_record_pre_action 13:27:22 INFO - Running main action method: download_and_extract 13:27:22 INFO - mkdir: /builds/slave/test/build/tests 13:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:22 INFO - trying https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.test_packages.json 13:27:22 INFO - Downloading https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:27:22 INFO - Downloaded 989 bytes. 13:27:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:27:22 INFO - Using the following test package requirements: 13:27:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:27:22 INFO - u'common': [u'target.common.tests.zip'], 13:27:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:27:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:27:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:27:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:27:22 INFO - u'mozbase': [u'target.common.tests.zip'], 13:27:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:27:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:27:22 INFO - u'web-platform': [u'target.common.tests.zip', 13:27:22 INFO - u'target.web-platform.tests.tar.gz'], 13:27:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:27:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.common.tests.zip 13:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.common.tests.zip into memory 13:27:24 INFO - Content-Length response header: 54734720 13:27:24 INFO - Bytes received: 54734720 13:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.talos.tests.zip 13:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.talos.tests.zip into memory 13:27:35 INFO - Content-Length response header: 14508749 13:27:35 INFO - Bytes received: 14508749 13:27:36 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')]} 13:27:36 INFO - trying https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 13:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:27:37 INFO - Downloaded 61377120 bytes. 13:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 13:27:37 INFO - mkdir: /builds/slave/test/properties 13:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:27:37 INFO - Contents: 13:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 13:27:37 INFO - Running post-action listener: _resource_record_post_action 13:27:37 INFO - Running post-action listener: find_tests_for_verification 13:27:37 INFO - Running post-action listener: set_extra_try_arguments 13:27:37 INFO - [mozharness: 2017-09-15 20:27:37.942340Z] Finished download-and-extract step (success) 13:27:37 INFO - [mozharness: 2017-09-15 20:27:37.942439Z] Running populate-webroot step. 13:27:37 INFO - Running pre-action listener: _resource_record_pre_action 13:27:37 INFO - Running main action method: populate_webroot 13:27:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:27:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['tresize', 13:27:37 INFO - 'tcanvasmark']}, 13:27:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:27:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['dromaeo_css', 13:27:37 INFO - 'kraken']}, 13:27:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'tests': ['damp', 'tps']}, 13:27:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['damp', 'tps']}, 13:27:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:27:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['dromaeo_dom']}, 13:27:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:27:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['basic_compositor_video', 13:27:37 INFO - 'glvideo']}, 13:27:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:27:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['ts_paint_webext', 13:27:37 INFO - 'tp5o_webext']}, 13:27:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:27:37 INFO - 'ts_paint', 13:27:37 INFO - 'tpaint', 13:27:37 INFO - 'sessionrestore', 13:27:37 INFO - 'sessionrestore_many_windows', 13:27:37 INFO - 'sessionrestore_no_auto_restore', 13:27:37 INFO - 'tabpaint']}, 13:27:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['a11yr', 13:27:37 INFO - 'ts_paint', 13:27:37 INFO - 'tpaint', 13:27:37 INFO - 'sessionrestore', 13:27:37 INFO - 'sessionrestore_many_windows', 13:27:37 INFO - 'sessionrestore_no_auto_restore', 13:27:37 INFO - 'tabpaint']}, 13:27:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:27:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:27:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['perf_reftest_singletons']}, 13:27:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['bloom_basic']}, 13:27:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:27:37 INFO - 'tsvgr_opacity', 13:27:37 INFO - 'tart', 13:27:37 INFO - 'tscrollx', 13:27:37 INFO - 'tsvg_static']}, 13:27:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['tsvgx', 13:27:37 INFO - 'tsvgr_opacity', 13:27:37 INFO - 'tart', 13:27:37 INFO - 'tscrollx', 13:27:37 INFO - 'tsvg_static']}, 13:27:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:27:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo'], 13:27:37 INFO - 'tests': ['tp5o']}, 13:27:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:27:37 INFO - 'talos_options': ['--mitmproxy', 13:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:27:37 INFO - '--firstNonBlankPaint'], 13:27:37 INFO - 'tests': ['tp6_google', 13:27:37 INFO - 'tp6_youtube', 13:27:37 INFO - 'tp6_amazon', 13:27:37 INFO - 'tp6_facebook']}, 13:27:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo', 13:27:37 INFO - '--mitmproxy', 13:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:27:37 INFO - '--firstNonBlankPaint'], 13:27:37 INFO - 'tests': ['tp6_google', 13:27:37 INFO - 'tp6_youtube', 13:27:37 INFO - 'tp6_amazon', 13:27:37 INFO - 'tp6_facebook']}, 13:27:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:27:37 INFO - 'talos_options': ['--stylo-threads=1', 13:27:37 INFO - '--mitmproxy', 13:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:27:37 INFO - '--firstNonBlankPaint'], 13:27:37 INFO - 'tests': ['tp6_google', 13:27:37 INFO - 'tp6_youtube', 13:27:37 INFO - 'tp6_amazon', 13:27:37 INFO - 'tp6_facebook']}, 13:27:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--xperf_path', 13:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:37 INFO - 'tests': ['tp5n']}, 13:27:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:27:37 INFO - 'talos_options': ['--disable-stylo', 13:27:37 INFO - '--xperf_path', 13:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:37 INFO - 'tests': ['tp5n']}}} 13:27:37 INFO - Running post-action listener: _resource_record_post_action 13:27:37 INFO - [mozharness: 2017-09-15 20:27:37.958032Z] Finished populate-webroot step (success) 13:27:37 INFO - [mozharness: 2017-09-15 20:27:37.958130Z] Running create-virtualenv step. 13:27:37 INFO - Running pre-action listener: _resource_record_pre_action 13:27:37 INFO - Running main action method: create_virtualenv 13:27:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:27:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:27:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:27:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:27:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:27:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:27:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:38 INFO - Installing pip...............done. 13:27:39 INFO - Return code: 0 13:27:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:27:39 INFO - Reading from file tmpfile_stdout 13:27:39 INFO - Output received: 13:27: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) 13:27:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27: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')]} 13:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27: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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27: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 13:27: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 13:27:39 INFO - Using env: {'DISPLAY': ':0', 13:27:39 INFO - 'HOME': '/home/cltbld', 13:27:39 INFO - 'LANG': 'en_US.UTF-8', 13:27:39 INFO - 'LANGUAGE': 'en_US:en', 13:27:39 INFO - 'LOGNAME': 'cltbld', 13:27:39 INFO - 'MAIL': '/var/mail/cltbld', 13:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:39 INFO - 'MOZ_NO_REMOTE': '1', 13:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:39 INFO - 'NO_EM_RESTART': '1', 13:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:39 INFO - 'PWD': '/builds/slave/test', 13:27:39 INFO - 'SHELL': '/bin/bash', 13:27:39 INFO - 'SHLVL': '1', 13:27:39 INFO - 'TERM': 'linux', 13:27:39 INFO - 'TMOUT': '86400', 13:27:39 INFO - 'USER': 'cltbld', 13:27:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:39 INFO - '_': '/tools/buildbot/bin/python'} 13:27:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:27:40 INFO - Downloading/unpacking pip>=1.5 13:27:40 INFO - Running setup.py egg_info for package pip 13:27:40 INFO - warning: no files found matching 'pip/cacert.pem' 13:27:40 INFO - warning: no files found matching '*.html' under directory 'docs' 13:27:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:27:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:27:40 INFO - Installing collected packages: pip 13:27:40 INFO - Found existing installation: pip 1.1 13:27:40 INFO - Uninstalling pip: 13:27:40 INFO - Successfully uninstalled pip 13:27:40 INFO - Running setup.py install for pip 13:27:40 INFO - warning: no files found matching 'pip/cacert.pem' 13:27:40 INFO - warning: no files found matching '*.html' under directory 'docs' 13:27:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:27:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:27:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:27:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:27:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:27:40 INFO - Successfully installed pip 13:27:40 INFO - Cleaning up... 13:27:40 INFO - Return code: 0 13:27:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:27: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')]} 13:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27: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')]} 13:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27: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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27: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 13:27: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 13:27:40 INFO - Using env: {'DISPLAY': ':0', 13:27:40 INFO - 'HOME': '/home/cltbld', 13:27:40 INFO - 'LANG': 'en_US.UTF-8', 13:27:40 INFO - 'LANGUAGE': 'en_US:en', 13:27:40 INFO - 'LOGNAME': 'cltbld', 13:27:40 INFO - 'MAIL': '/var/mail/cltbld', 13:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:40 INFO - 'MOZ_NO_REMOTE': '1', 13:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:40 INFO - 'NO_EM_RESTART': '1', 13:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:40 INFO - 'PWD': '/builds/slave/test', 13:27:40 INFO - 'SHELL': '/bin/bash', 13:27:40 INFO - 'SHLVL': '1', 13:27:40 INFO - 'TERM': 'linux', 13:27:40 INFO - 'TMOUT': '86400', 13:27:40 INFO - 'USER': 'cltbld', 13:27:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:40 INFO - '_': '/tools/buildbot/bin/python'} 13:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:40 INFO - Downloading/unpacking psutil>=3.1.1 13:27:40 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 13:27:40 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 13:27:40 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 13:27:40 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 13:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:41 INFO - Installing collected packages: psutil 13:27:41 INFO - Running setup.py install for psutil 13:27:41 INFO - building 'psutil._psutil_linux' extension 13:27:41 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 13:27:42 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 13:27:42 INFO - building 'psutil._psutil_posix' extension 13:27:42 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 13:27:42 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 13:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:42 INFO - Successfully installed psutil 13:27:42 INFO - Cleaning up... 13:27:42 INFO - Return code: 0 13:27:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:42 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:42 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 13:27:42 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 13:27:42 INFO - Using env: {'DISPLAY': ':0', 13:27:42 INFO - 'HOME': '/home/cltbld', 13:27:42 INFO - 'LANG': 'en_US.UTF-8', 13:27:42 INFO - 'LANGUAGE': 'en_US:en', 13:27:42 INFO - 'LOGNAME': 'cltbld', 13:27:42 INFO - 'MAIL': '/var/mail/cltbld', 13:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:42 INFO - 'MOZ_NO_REMOTE': '1', 13:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:42 INFO - 'NO_EM_RESTART': '1', 13:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:42 INFO - 'PWD': '/builds/slave/test', 13:27:42 INFO - 'SHELL': '/bin/bash', 13:27:42 INFO - 'SHLVL': '1', 13:27:42 INFO - 'TERM': 'linux', 13:27:42 INFO - 'TMOUT': '86400', 13:27:42 INFO - 'USER': 'cltbld', 13:27:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:42 INFO - '_': '/tools/buildbot/bin/python'} 13:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:27:42 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 13:27:42 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 13:27:42 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 13:27:42 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 13:27:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:27:43 INFO - Installing collected packages: mozsystemmonitor 13:27:43 INFO - Running setup.py install for mozsystemmonitor 13:27:43 INFO - Successfully installed mozsystemmonitor 13:27:43 INFO - Cleaning up... 13:27:44 INFO - Return code: 0 13:27:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:27:44 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')]} 13:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:44 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')]} 13:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:44 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:44 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 13:27:44 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 13:27:44 INFO - Using env: {'DISPLAY': ':0', 13:27:44 INFO - 'HOME': '/home/cltbld', 13:27:44 INFO - 'LANG': 'en_US.UTF-8', 13:27:44 INFO - 'LANGUAGE': 'en_US:en', 13:27:44 INFO - 'LOGNAME': 'cltbld', 13:27:44 INFO - 'MAIL': '/var/mail/cltbld', 13:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:44 INFO - 'MOZ_NO_REMOTE': '1', 13:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:44 INFO - 'NO_EM_RESTART': '1', 13:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:44 INFO - 'PWD': '/builds/slave/test', 13:27:44 INFO - 'SHELL': '/bin/bash', 13:27:44 INFO - 'SHLVL': '1', 13:27:44 INFO - 'TERM': 'linux', 13:27:44 INFO - 'TMOUT': '86400', 13:27:44 INFO - 'USER': 'cltbld', 13:27:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:44 INFO - '_': '/tools/buildbot/bin/python'} 13:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:44 INFO - Downloading/unpacking jsonschema==2.5.1 13:27:44 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 13:27:44 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 13:27:44 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 13:27:44 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 13:27:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:27: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 13:27: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 13:27: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 13:27: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 13:27:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:46 INFO - warning: no files found matching '*.txt' 13:27:46 INFO - no previously-included directories found matching 'build' 13:27:46 INFO - no previously-included directories found matching 'dist' 13:27:46 INFO - no previously-included directories found matching '.git*' 13:27:46 INFO - Installing collected packages: jsonschema, functools32 13:27:46 INFO - Running setup.py install for functools32 13:27:46 INFO - warning: no files found matching '*.txt' 13:27:46 INFO - no previously-included directories found matching 'build' 13:27:46 INFO - no previously-included directories found matching 'dist' 13:27:46 INFO - no previously-included directories found matching '.git*' 13:27:46 INFO - Successfully installed jsonschema functools32 13:27:46 INFO - Cleaning up... 13:27:46 INFO - Return code: 0 13:27:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:27:46 INFO - Using env: {'DISPLAY': ':0', 13:27:46 INFO - 'HOME': '/home/cltbld', 13:27:46 INFO - 'LANG': 'en_US.UTF-8', 13:27:46 INFO - 'LANGUAGE': 'en_US:en', 13:27:46 INFO - 'LOGNAME': 'cltbld', 13:27:46 INFO - 'MAIL': '/var/mail/cltbld', 13:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:46 INFO - 'MOZ_NO_REMOTE': '1', 13:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:46 INFO - 'NO_EM_RESTART': '1', 13:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:46 INFO - 'PWD': '/builds/slave/test', 13:27:46 INFO - 'SHELL': '/bin/bash', 13:27:46 INFO - 'SHLVL': '1', 13:27:46 INFO - 'TERM': 'linux', 13:27:46 INFO - 'TMOUT': '86400', 13:27:46 INFO - 'USER': 'cltbld', 13:27:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:46 INFO - '_': '/tools/buildbot/bin/python'} 13:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:27:46 INFO - Cleaning up... 13:27:46 INFO - Return code: 0 13:27:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:27:46 INFO - Using env: {'DISPLAY': ':0', 13:27:46 INFO - 'HOME': '/home/cltbld', 13:27:46 INFO - 'LANG': 'en_US.UTF-8', 13:27:46 INFO - 'LANGUAGE': 'en_US:en', 13:27:46 INFO - 'LOGNAME': 'cltbld', 13:27:46 INFO - 'MAIL': '/var/mail/cltbld', 13:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:46 INFO - 'MOZ_NO_REMOTE': '1', 13:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:46 INFO - 'NO_EM_RESTART': '1', 13:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:46 INFO - 'PWD': '/builds/slave/test', 13:27:46 INFO - 'SHELL': '/bin/bash', 13:27:46 INFO - 'SHLVL': '1', 13:27:46 INFO - 'TERM': 'linux', 13:27:46 INFO - 'TMOUT': '86400', 13:27:46 INFO - 'USER': 'cltbld', 13:27:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:46 INFO - '_': '/tools/buildbot/bin/python'} 13:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:46 INFO - Downloading/unpacking blobuploader==1.2.4 13:27: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 13:27: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 13:27: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 13:27: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 13:27:47 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27: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 13:27: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 13:27: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 13:27: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 13:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27: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 13:27: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 13:27: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 13:27: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 13:27:48 INFO - Downloading docopt-0.6.1.tar.gz 13:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:48 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:48 INFO - Running setup.py install for blobuploader 13:27:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:48 INFO - Running setup.py install for requests 13:27:48 INFO - Running setup.py install for docopt 13:27:48 INFO - Successfully installed blobuploader requests docopt 13:27:48 INFO - Cleaning up... 13:27:48 INFO - Return code: 0 13:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:48 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')]} 13:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:49 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:49 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 13:27:49 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 13:27:49 INFO - Using env: {'DISPLAY': ':0', 13:27:49 INFO - 'HOME': '/home/cltbld', 13:27:49 INFO - 'LANG': 'en_US.UTF-8', 13:27:49 INFO - 'LANGUAGE': 'en_US:en', 13:27:49 INFO - 'LOGNAME': 'cltbld', 13:27:49 INFO - 'MAIL': '/var/mail/cltbld', 13:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:49 INFO - 'MOZ_NO_REMOTE': '1', 13:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:49 INFO - 'NO_EM_RESTART': '1', 13:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:49 INFO - 'PWD': '/builds/slave/test', 13:27:49 INFO - 'SHELL': '/bin/bash', 13:27:49 INFO - 'SHLVL': '1', 13:27:49 INFO - 'TERM': 'linux', 13:27:49 INFO - 'TMOUT': '86400', 13:27:49 INFO - 'USER': 'cltbld', 13:27:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:49 INFO - '_': '/tools/buildbot/bin/python'} 13:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:49 INFO - Running setup.py (path:/tmp/pip-P7M0NW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:49 INFO - Running setup.py (path:/tmp/pip-ALS54X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:49 INFO - Running setup.py (path:/tmp/pip-JViecT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:49 INFO - Running setup.py (path:/tmp/pip-EY1Wak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:49 INFO - Running setup.py (path:/tmp/pip-clersq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:49 INFO - Running setup.py (path:/tmp/pip-5NN8GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:49 INFO - Running setup.py (path:/tmp/pip-eADEJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:49 INFO - Running setup.py (path:/tmp/pip-9cz5GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:49 INFO - Running setup.py (path:/tmp/pip-i9FDGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:49 INFO - Running setup.py (path:/tmp/pip-W02Zf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:49 INFO - Running setup.py (path:/tmp/pip-Rp90xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:49 INFO - Running setup.py (path:/tmp/pip-HYqy1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:50 INFO - Running setup.py (path:/tmp/pip-zXwbyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:50 INFO - Running setup.py (path:/tmp/pip-jpzVtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:50 INFO - Running setup.py (path:/tmp/pip-f4vSia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:50 INFO - Running setup.py (path:/tmp/pip-Laf4T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:50 INFO - Running setup.py (path:/tmp/pip-3F7VWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:50 INFO - Running setup.py install for manifestparser 13:27:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:50 INFO - Running setup.py install for mozcrash 13:27:50 INFO - Running setup.py install for mozdebug 13:27:50 INFO - Running setup.py install for mozdevice 13:27:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:50 INFO - Running setup.py install for mozfile 13:27:50 INFO - Running setup.py install for mozhttpd 13:27:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:50 INFO - Running setup.py install for mozinfo 13:27:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for mozInstall 13:27:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for mozleak 13:27:51 INFO - Running setup.py install for mozlog 13:27:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for moznetwork 13:27:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for mozprocess 13:27:51 INFO - Running setup.py install for mozprofile 13:27:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for mozrunner 13:27:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:51 INFO - Running setup.py install for mozscreenshot 13:27:51 INFO - Running setup.py install for moztest 13:27:52 INFO - Running setup.py install for mozversion 13:27:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:52 INFO - Cleaning up... 13:27:52 INFO - Return code: 0 13:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:52 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:52 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 13:27:52 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 13:27:52 INFO - Using env: {'DISPLAY': ':0', 13:27:52 INFO - 'HOME': '/home/cltbld', 13:27:52 INFO - 'LANG': 'en_US.UTF-8', 13:27:52 INFO - 'LANGUAGE': 'en_US:en', 13:27:52 INFO - 'LOGNAME': 'cltbld', 13:27:52 INFO - 'MAIL': '/var/mail/cltbld', 13:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:52 INFO - 'MOZ_NO_REMOTE': '1', 13:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:52 INFO - 'NO_EM_RESTART': '1', 13:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:52 INFO - 'PWD': '/builds/slave/test', 13:27:52 INFO - 'SHELL': '/bin/bash', 13:27:52 INFO - 'SHLVL': '1', 13:27:52 INFO - 'TERM': 'linux', 13:27:52 INFO - 'TMOUT': '86400', 13:27:52 INFO - 'USER': 'cltbld', 13:27:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:52 INFO - '_': '/tools/buildbot/bin/python'} 13:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:52 INFO - Running setup.py (path:/tmp/pip-vw8aOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:52 INFO - Running setup.py (path:/tmp/pip-1h_j4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:52 INFO - Running setup.py (path:/tmp/pip-zmiLFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:52 INFO - Running setup.py (path:/tmp/pip-eihbcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:52 INFO - Running setup.py (path:/tmp/pip-RyjYEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:52 INFO - Running setup.py (path:/tmp/pip-U4gpQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:52 INFO - Running setup.py (path:/tmp/pip-azYBdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:52 INFO - Running setup.py (path:/tmp/pip-OrE4TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:52 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)) 13:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:52 INFO - Running setup.py (path:/tmp/pip-l5Y6pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:53 INFO - Running setup.py (path:/tmp/pip-whBj2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:53 INFO - Running setup.py (path:/tmp/pip-XSHGmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:53 INFO - Running setup.py (path:/tmp/pip-1_Xbdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:53 INFO - Running setup.py (path:/tmp/pip-9HkKzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:53 INFO - Running setup.py (path:/tmp/pip-SnPk1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:53 INFO - Running setup.py (path:/tmp/pip-KjLl74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:53 INFO - Running setup.py (path:/tmp/pip-QWj1jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:53 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)) 13:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:53 INFO - Running setup.py (path:/tmp/pip-73eUcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:53 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)) 13:27:53 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)) 13:27:53 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)) 13:27:53 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)) 13:27:53 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)) 13:27:53 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)) 13:27:53 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)) 13:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:54 INFO - Downloading blessings-1.6.tar.gz 13:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:54 INFO - Installing collected packages: blessings 13:27:54 INFO - Running setup.py install for blessings 13:27:54 INFO - Successfully installed blessings 13:27:54 INFO - Cleaning up... 13:27:54 INFO - Return code: 0 13:27:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:55 INFO - Reading from file tmpfile_stdout 13:27:55 INFO - Current package versions: 13:27:55 INFO - argparse == 1.2.1 13:27:55 INFO - blessings == 1.6 13:27:55 INFO - blobuploader == 1.2.4 13:27:55 INFO - docopt == 0.6.1 13:27:55 INFO - functools32 == 3.2.3-2 13:27:55 INFO - jsonschema == 2.5.1 13:27:55 INFO - manifestparser == 1.1 13:27:55 INFO - mozInstall == 1.13 13:27:55 INFO - mozcrash == 1.0 13:27:55 INFO - mozdebug == 0.1 13:27:55 INFO - mozdevice == 0.51 13:27:55 INFO - mozfile == 1.2 13:27:55 INFO - mozhttpd == 0.7 13:27:55 INFO - mozinfo == 0.10 13:27:55 INFO - mozleak == 0.1 13:27:55 INFO - mozlog == 3.5 13:27:55 INFO - moznetwork == 0.27 13:27:55 INFO - mozprocess == 0.25 13:27:55 INFO - mozprofile == 0.28 13:27:55 INFO - mozrunner == 6.13 13:27:55 INFO - mozscreenshot == 0.1 13:27:55 INFO - mozsystemmonitor == 0.3 13:27:55 INFO - moztest == 0.8 13:27:55 INFO - mozversion == 1.4 13:27:55 INFO - psutil == 3.1.1 13:27:55 INFO - requests == 1.2.3 13:27:55 INFO - wsgiref == 0.1.2 13:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:55 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:55 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 13:27:55 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 13:27:55 INFO - Using env: {'DISPLAY': ':0', 13:27:55 INFO - 'HOME': '/home/cltbld', 13:27:55 INFO - 'LANG': 'en_US.UTF-8', 13:27:55 INFO - 'LANGUAGE': 'en_US:en', 13:27:55 INFO - 'LOGNAME': 'cltbld', 13:27:55 INFO - 'MAIL': '/var/mail/cltbld', 13:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:55 INFO - 'MOZ_NO_REMOTE': '1', 13:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:55 INFO - 'NO_EM_RESTART': '1', 13:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:55 INFO - 'PWD': '/builds/slave/test', 13:27:55 INFO - 'SHELL': '/bin/bash', 13:27:55 INFO - 'SHLVL': '1', 13:27:55 INFO - 'TERM': 'linux', 13:27:55 INFO - 'TMOUT': '86400', 13:27:55 INFO - 'USER': 'cltbld', 13:27:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:55 INFO - '_': '/tools/buildbot/bin/python'} 13:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 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)) 13:27:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:27:56 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)) 13:27:56 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)) 13:27:56 INFO - Installing collected packages: simplejson 13:27:56 INFO - Running setup.py install for simplejson 13:27:56 INFO - building 'simplejson._speedups' extension 13:27:56 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 13:27:57 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 13:27:57 INFO - Successfully installed simplejson 13:27:57 INFO - Cleaning up... 13:27:57 INFO - Return code: 0 13:27:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:57 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 0x24211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', '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 13:27:57 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 13:27:57 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 13:27:57 INFO - Using env: {'DISPLAY': ':0', 13:27:57 INFO - 'HOME': '/home/cltbld', 13:27:57 INFO - 'LANG': 'en_US.UTF-8', 13:27:57 INFO - 'LANGUAGE': 'en_US:en', 13:27:57 INFO - 'LOGNAME': 'cltbld', 13:27:57 INFO - 'MAIL': '/var/mail/cltbld', 13:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:57 INFO - 'MOZ_NO_REMOTE': '1', 13:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:57 INFO - 'NO_EM_RESTART': '1', 13:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:57 INFO - 'PWD': '/builds/slave/test', 13:27:57 INFO - 'SHELL': '/bin/bash', 13:27:57 INFO - 'SHLVL': '1', 13:27:57 INFO - 'TERM': 'linux', 13:27:57 INFO - 'TMOUT': '86400', 13:27:57 INFO - 'USER': 'cltbld', 13:27:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:57 INFO - '_': '/tools/buildbot/bin/python'} 13:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:57 INFO - Cleaning up... 13:27:57 INFO - Return code: 0 13:27:57 INFO - Running post-action listener: _resource_record_post_action 13:27:57 INFO - Running post-action listener: _start_resource_monitoring 13:27:57 INFO - Starting resource monitoring. 13:27:57 INFO - [mozharness: 2017-09-15 20:27:57.932808Z] Finished create-virtualenv step (success) 13:27:57 INFO - [mozharness: 2017-09-15 20:27:57.933309Z] Running install step. 13:27:57 INFO - Running pre-action listener: _resource_record_pre_action 13:27:57 INFO - Running main action method: install 13:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:58 INFO - Reading from file tmpfile_stdout 13:27:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:58 INFO - Reading from file tmpfile_stdout 13:27:58 INFO - Output received: 13:27:58 INFO - Usage: mozinstall [options] installer 13:27:58 INFO - Options: 13:27:58 INFO - -h, --help show this help message and exit 13:27:58 INFO - -d DEST, --destination=DEST 13:27:58 INFO - Directory to install application into. [default: 13:27:58 INFO - "/builds/slave/test"] 13:27:58 INFO - --app=APP Application being installed. [default: firefox] 13:27:58 INFO - mkdir: /builds/slave/test/build/application 13:27:58 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'] 13:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:28:16 INFO - Reading from file tmpfile_stdout 13:28:16 INFO - Output received: 13:28:16 INFO - /builds/slave/test/build/application/firefox/firefox 13:28:16 INFO - Running post-action listener: _resource_record_post_action 13:28:16 INFO - [mozharness: 2017-09-15 20:28:16.082652Z] Finished install step (success) 13:28:16 INFO - [mozharness: 2017-09-15 20:28:16.082901Z] Running setup-mitmproxy step. 13:28:16 INFO - Running pre-action listener: _resource_record_pre_action 13:28:16 INFO - Running main action method: setup_mitmproxy 13:28:16 INFO - Skipping: mitmproxy is not required 13:28:16 INFO - Running post-action listener: _resource_record_post_action 13:28:16 INFO - [mozharness: 2017-09-15 20:28:16.084079Z] Finished setup-mitmproxy step (success) 13:28:16 INFO - [mozharness: 2017-09-15 20:28:16.084299Z] Running run-tests step. 13:28:16 INFO - Running pre-action listener: _resource_record_pre_action 13:28:16 INFO - Running pre-action listener: _set_gcov_prefix 13:28:16 INFO - Running main action method: run_tests 13:28:16 WARNING - Try message not found. 13:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:28:16 INFO - Python 2.7.3 13:28:16 INFO - Return code: 0 13:28:16 INFO - grabbing minidump binary from tooltool 13:28:16 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')]} 13:28:16 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 0x2791090>, '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 0x2791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x278bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:28:16 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 13:28:16 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 13:28:16 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 13:28:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:16 INFO - Return code: 0 13:28:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:28:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:28:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:28:16 INFO - ENV: RUST_BACKTRACE is now full 13:28:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:28:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 13:28:16 INFO - Using env: {'DISPLAY': ':0', 13:28:16 INFO - 'HOME': '/home/cltbld', 13:28:16 INFO - 'LANG': 'en_US.UTF-8', 13:28:16 INFO - 'LANGUAGE': 'en_US:en', 13:28:16 INFO - 'LOGNAME': 'cltbld', 13:28:16 INFO - 'MAIL': '/var/mail/cltbld', 13:28:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:16 INFO - 'MOZ_NO_REMOTE': '1', 13:28:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:16 INFO - 'NO_EM_RESTART': '1', 13:28:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:16 INFO - 'PWD': '/builds/slave/test', 13:28:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:16 INFO - 'RUST_BACKTRACE': 'full', 13:28:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:28:16 INFO - 'SHELL': '/bin/bash', 13:28:16 INFO - 'SHLVL': '1', 13:28:16 INFO - 'TERM': 'linux', 13:28:16 INFO - 'TMOUT': '86400', 13:28:16 INFO - 'USER': 'cltbld', 13:28:16 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:16 INFO - '_': '/tools/buildbot/bin/python'} 13:28:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 13:28:16 INFO - mozversion application_buildid: 20170915193347 13:28:16 INFO - mozversion application_changeset: 6be5c7d30d2def62a762ac187252eba626b23a92 13:28:16 INFO - mozversion application_display_name: Nightly 13:28:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:16 INFO - mozversion application_name: Firefox 13:28:16 INFO - mozversion application_remotingname: firefox 13:28:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:28:16 INFO - mozversion application_vendor: Mozilla 13:28:16 INFO - mozversion application_version: 57.0a1 13:28:16 INFO - mozversion platform_buildid: 20170915193347 13:28:16 INFO - mozversion platform_changeset: 6be5c7d30d2def62a762ac187252eba626b23a92 13:28:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:28:16 INFO - mozversion platform_version: 57.0a1 13:28:16 INFO - using testdate: 1505507296 13:28:16 INFO - actual date: 1505507296 13:28:16 INFO - starting webserver on 'localhost:60951' 13:28:16 INFO - SUITE-START | Running 2 tests 13:28:16 INFO - TEST-START | dromaeo_css 13:28:16 INFO - Initialising browser for dromaeo_css test... 13:28:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60951/getInfo.html -profile /tmp/tmpjCzThX/profile 13:28:16 INFO - TEST-INFO | started process 15962 (/builds/slave/test/build/application/firefox/firefox http://localhost:60951/getInfo.html) 13:28:22 INFO - TEST-INFO | 15962: exit 0 13:28:22 INFO - Browser initialized. 13:28:22 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:22 INFO - Using env: {'DISPLAY': ':0', 13:28:22 INFO - 'HOME': '/home/cltbld', 13:28:22 INFO - 'JSGC_DISABLE_POISONING': '1', 13:28:22 INFO - 'LANG': 'en_US.UTF-8', 13:28:22 INFO - 'LANGUAGE': 'en_US:en', 13:28:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:28:22 INFO - 'LOGNAME': 'cltbld', 13:28:22 INFO - 'MAIL': '/var/mail/cltbld', 13:28:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:28:22 INFO - 'MOZ_CRASHREPORTER': '1', 13:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:28:22 INFO - 'MOZ_NO_REMOTE': '1', 13:28:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:22 INFO - 'NO_EM_RESTART': '1', 13:28:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:22 INFO - 'PWD': '/builds/slave/test', 13:28:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:22 INFO - 'RUST_BACKTRACE': 'full', 13:28:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:28:22 INFO - 'SHELL': '/bin/bash', 13:28:22 INFO - 'SHLVL': '1', 13:28:22 INFO - 'TERM': 'linux', 13:28:22 INFO - 'TMOUT': '86400', 13:28:22 INFO - 'USER': 'cltbld', 13:28:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:22 INFO - '_': '/tools/buildbot/bin/python'} 13:28:22 INFO - TEST-INFO | started process 16198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjCzThX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:23 INFO - PID 16198 | 13:28:23 INFO - PID 16198 | (/builds/slave/test/build/application/firefox/firefox:16246): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:28:23 INFO - PID 16198 | 13:28:33 INFO - PID 16198 | RSS: Main: 171618304 13:28:33 INFO - PID 16198 | 13:31:30 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60951/tests/dromaeo/cssquery-ext.html) 13:31:31 INFO - PID 16198 | RSS: Main: 175562752 13:31:31 INFO - PID 16198 | 13:34:33 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-ext.html (next: http://localhost:60951/tests/dromaeo/cssquery-jquery.html) 13:34:34 INFO - PID 16198 | RSS: Main: 171200512 13:34:34 INFO - PID 16198 | 13:37:36 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60951/tests/dromaeo/cssquery-mootools.html) 13:37:36 INFO - PID 16198 | RSS: Main: 174280704 13:37:36 INFO - PID 16198 | 13:40:38 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60951/tests/dromaeo/cssquery-prototype.html) 13:40:38 INFO - PID 16198 | RSS: Main: 172400640 13:40:38 INFO - PID 16198 | 13:43:42 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60951/tests/dromaeo/cssquery-yui.html) 13:43:42 INFO - PID 16198 | RSS: Main: 174362624 13:43:42 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | Cycle 1(1): loaded http://localhost:60951/tests/dromaeo/cssquery-yui.html (next: http://localhost:60951/tests/dromaeo/cssquery-dojo.html) 13:46:44 INFO - PID 16198 | RSS: Main: 174940160 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | __start_tp_report 13:46:44 INFO - PID 16198 | _x_x_mozilla_page_load 13:46:44 INFO - PID 16198 | _x_x_mozilla_page_load_details 13:46:44 INFO - PID 16198 | |i|pagename|runs| 13:46:44 INFO - PID 16198 | |0;dojo.html;3067.785255032146;3075.9846200769;3088.089013740947;3092.7061929116726;3112.1752735525088;5992.490638295744;6042.425969532887;6088.543359248052;6095.634261944281;6158.414950579693;6161.414665606771;6199.039148931912;6276.121343011982;6276.968615156929;6282.780102696406;5740.081586946089;5743.856403589902;5861.58968872177;5862.530997520188;5873.148393482942;5770.2210201622665;5828.825135245949;5857.033589457735;5890.057590785475;5940.88118237635;976.9725325999016;5294.232336311233;5681.034224181878;5767.88464230713;5807.274090738658;5711.171880077365;5735.1970724098655;5803.129530570406;5814.215080964101;5828.737706803204;5704.629199102045;5741.511971482387;5801.970990145022;5805.622634528784;5805.796797112123;6203.782867599657;6223.968880155616;6235.688215589248;6287.654179020152;6292;6603.240627327823;6637.800865974028;6647.235567909655;6736.797896063126;6778.322167783232;6468.741250350027;6540.247871494791;6542.051402546652;6544.247411547685;6548.607083574953;6091.664958427285;6150.354212807635;6168.722407491674;6170.136180934673;6173.783917562909;6758.493113016445;6807.115075040213;6851.006604042386;6929.549579277331;6968.721251149897;6584.012398140318;6646.6676666166495;6666.366695163952;6670.166229221348;6674.432673222734;6682.498812589075;6714.060031595581;6714.29499902513;6781.084553585301;6803.591784492946;6500.869982600321;6580.605163690194;6606.504512161511;6611.966940165268;6617.073609694647;6553.967230163818;6586.6377349245295;6650.53446258767;6651.966740166365;6655;5150.4334523202415;5215.817446389434;5216.035033518811;5220.5823534117935;5224.555912747459;4509.413776209138;4540.318952157137;4540.88647783808;4549.658775591844;4557.908841823145;5671.659700417906;5685.260916080966;5740.512056475163;5755.280589926259;5759;6768.830779230559;6782.152230971129;6783.18601767791;6784.6946887389195;6793.864122717617;5771.192033115367;5776.306843178845;5837.09525023622;5851.824445266649;5853.385394533598;5747.971260143672;5749.396313387034;5823.796167134215;5825.679587622722;5835.066389377679;6264.21697287839;6376.617402955838;6466.741330346734;6553.984132459476;6571.572847764975;6761.932380676229;6792.049113124167;6793.490488213305;6794.626295553792;6811.2167100784045;6460.612363258219;6463.515236357386;6467.611943283418;6538.346165383424;6561.081448597296;6374.3306952771145;6551.574147680385;6556.803295901131;6656.0348749430095;6658.6337751424135;6655.733770649314;6713.328667133248;6783.491238157059;6793.116894803644;6795.286494917962;6565.737370505126;6573.244076931214;6574.276829548841;6589.769358072444;6604.174478190226;6479.416852483299;6483.286838447862;6514.511411644051;6588.4399826013405;6602.603843769197;6274.435300822765;6391.96804015977;6473.417392434515;6482.902756458751;6488.805335839932;6503.447206987459;6528.281888992112;6549.115869357575;6556.311587283458;6634.635095069818;6354.93645063562;6360.77737279193;6370.140031095742;6435.195600549931;6450.741970321134 13:46:44 INFO - PID 16198 | |1;ext.html;812.8983877015373;837.0415873824471;847.8855354527141;861.7931696392867;864.209248537588;40450.79774601127;41268.174636507254;41280.79359603202;41287.38068928968;41728.58271417285;38344.61655383445;40905.18189636205;41407.79296103523;41438.58561414385;41469.792651036776;7653.0816302043695;7769.417293702967;7777.222277772205;7789.4157938154585;7791.065072191345;7585.848283034336;7678.923210767876;7698.807529811772;7706.306432421081;7709.498882572615;7708.57602831844;7722.382209423261;7731.072271327449;7738.806529836743;7739.7678069658;7668;7671;7687.615619219045;7712.961435192844;7719.073711154641;7563.508371955805;7598.126215485179;7608.277213664693;7610;7611.809704757426;37021.81489092537;37154.44268335977;37234;37443;37595.81202093972;3526.7531272810916;3560.2345495718546;3572.5712914450173;3601.2797440512004;3603.531540899666;30737.846310768302;30833.691663083308;30843.53734693959;30844.691553084405;30858.845705771553;5007.37407824022;5131.615128865313;5133.948660513384;5154.92267615986;5173.715445650488;186503;187502;188597.05701471542;190474;199197;48018;48113.75943120262;48481.757591212525;48516;48585.27122093172;50438;50455.24317135246;50456.74771626118;50563.241551376756;50573.49426505688;15825.604359891095;15868.603284917739;15994;16005.199740012953;16103.1143287118;13219.140755851031;13310.334483275798;13329.866701333056;13346.332683365792;13360.465581376831;12866.163699359511;12887.871121288666;13010.544630937871;13113.541026064042;13128.737425251442;5298.735063246822;5379.515843574097;5391.056565101092;5391.514763671288;5393.5954803389905;998.650472334677;1012.8733908261468;1014.0974532665933;1025.9846102308472;1039.7244730146517;22776.2028329011;22872.7712722874;22954.65568016481;23139.611623302655;23493.530129397317;1088.4666513408372;1099.4777480696605;1109.5949978258038;1114.1309778372881;1114.726891911487;11967.820482692767;12076.430064091612;12143.817842732366;12183.573574925013;12240.75518489643;229682;230048;230269;230815;231441;52440.47559524432;52608.47391526112;52864.20703689448;57719;58007.41992580105;1409.654634614526;1460.072853737884;1461.2328527522923;1470.1767010474168;1474.0418727826784;28130.43739125165;28218.153455396372;28380;28486.57270140908;28915.85542072276;34009.48985765265;37355;38145.618543814206;38204.42693359657;38332.42501362426;192390;195423;195635;195887;196371;31533.211669708442;31966.840165799953;32133;32998.83500582482;35060;43022.56977430185;43448.13103737971;43605;43765;43970.560294397925;31924.68075319217;31935;32163.678363217005;32331.19172020718;32744.672553275115;31568.36863262676;31818;31938.52092218665;32073.198170045936;33004.50493242651;35595.466068008485;35837.283254335285;35994.28011439809;35994.28011439809;36091.458628120075;30745;30748.692513074584;31260.374792504477;31365.372692546476;31508.842455787573;22187.889060554593;22218.222362217246;22770.43073923165;23111.76888231096;23120.421989449726 13:46:44 INFO - PID 16198 | |2;jquery.html;563.9238702775124;563.9887202255958;565.1945976982798;567.4989652369483;602.6022824935542;22017.779822201774;22790.544189116208;22801.201957931476;22810.429739256528;22826.771732282672;23360.415989600267;24084.879575602143;24498.87750561249;24703.75296247037;24808.379790505245;6373.649449280288;6469.547131700783;6495.707693153796;6506.186726659168;6506.284308726036;6366.204224471941;6468.482521398277;6469.644169570672;6472;6472.288048314682;6335.3981371769605;6390.265119511246;6600.339966003386;6600.471962243009;6615.569987950792;6616.735330586771;6666.333366663343;6671.899921501205;6674.432673222782;6675.86648267032;6148.354422785633;6155.969220153916;6157.876842463125;6160.507159427235;6169.629822210682;27018.45963080747;27686.86156569204;28142.859285703442;28295.434091318264;28330;1996.6805311150292;2031.5022819409191;2033.0851116997262;2036.8370530357536;2042.7650820155723;19326.516837079045;19644.11601477937;19657.11542980555;19659.311924082587;19682.70475942862;2359.858408495496;2419.552382809168;2429.5626787178303;2431.8176136789634;2508.94982100357;116136;121872;129619;132785.33607331998;135383.3230833859;14298.57104286873;14465.291176123097;14644;14708.043977141666;14709.55871323862;22313.55372892533;22333.55332893333;22337;22401.327960161223;22431.887840560692;9628.229741620653;10167.694969150938;10168.745781355525;10303.536340864679;10318.948405258076;9405.482698451651;9457.574409151604;9505;9641.662541811003;9677.129058384779;8582.313414926792;8750.956245218733;8899.955500222586;8902.777430564287;8921.598528066253;2620.6241723095527;2633.6839579250613;2675.1305825606755;2710.8780104895327;2723.1694333228556;935.3499317974079;960.6157536985122;969.2827307792325;969.5055521683992;971.358903123949;18731.625367492845;19189.136488858036;19433.319833806032;19463.708044379346;19500;1018.4398580780542;1031.3811712972156;1033.426448321189;1047.9004494573003;1053.3258714422775;10519;10532.262741608167;10674.57301707923;10864.158067706081;10915.454227288605;473068;487620;487718;491704;504991;107568.23511177071;110012.4499377498;110641.44679276552;110676.4466177664;111461;1030.1449796668746;1075.086176749772;1145.627671006926;1170.0756402441975;1189.1556994533978;20018.89990550038;20037.09833057545;20056.398308050782;20066.398008059783;20449.48876278105;53483.46516534785;55460.60391895264;55630;55653.44346556483;56626.15060774009;69676.6516167416;70451;70466;70919;72256.63871680819;13914.373853176834;14237.074590151607;14316;14405.703486686249;14415.78376324335;22362.329130126123;22399.104035838383;22472.101115955178;22500.887495562416;22628.434289142246;17199.57001074983;17957.102144892964;18504.444866654023;18522.166502507687;18534.16596253145;15675.921620391826;16083.115428651536;16150.353985840435;16464.506064818073;16551.08969006716;17829.46511604654;18443.907780461013;18500.444986650422;18503.35238266654;18573.81426185721;14047.227402492961;14055.929720351332;14057.226852522801;14127.223002734949;14144.363503642566;17561.648767024843;17710.114494274978;17894;18038.819611803712;18071.638567228845 13:46:44 INFO - PID 16198 | |3;mootools.html;1351.6012776231012;1395.4209003263652;1397.7763557830742;1402.3549167383003;1409.1474657832014;14961.326740296685;15610.76583851243;15624.531264062069;15635.921820390897;15654.373825047012;15183.544493665207;15329.616759581017;15329.69340613187;15353.232338383092;15370.615734606641;2770.819896706718;2812.7187281271913;2873.454043731684;2879.539273716206;2879.812812167213;2789.846558439285;2800.4119134981574;2817.7745780337523;2818.112294627196;2818.3236023354348;2672.4788666210097;2779.5413756730113;2876.798624096314;2878.8272703637745;2880.2799300174956;2812.2406950123554;2834.6740124885696;2884.956725649117;2887.3647797484728;2887.8267303961725;2773.486904922596;2787.4982503149427;2798.8320700757818;2815.7465828075365;2827.067067867599;15051.849481505154;15159.393624255017;15287.312070956834;15292.770608440882;15299.46451874179;8121.878171827428;8402.285805706522;8406.453580517247;8422.620982055822;8438.36712246584;5437.184422336642;5585.972070139624;5732.799352022701;5763.5101016413655;5803.346046376804;1856.4709057918562;1879.8590105741987;1890.5368184794677;1921.5868588253593;1933.1011079847938;25991;26229.73770262292;26278.343041424116;26298.21105366842;26333.868330658417;6877.965610171917;6880.621565813828;6892.965535172392;7075.540089894141;7131.536450130725;16745.330186792635;17076;17107.74338384925;17131.97208167514;17143.314267429414;8047.798805029921;8329;8579.399442038997;8612.5693715314;8624.52565108925;7640.808979775439;7650.73222437212;7653.770386888402;7656.846863062708;7677.846443071219;5060;5182.481751824863;5185.585153187812;5200.92198617021;5208.0365132450615;1436.4685066525244;1441.358595425026;1537.823150337703;1585.8334874838206;1588.0471716969726;858.7252079334678;875.3872289397448;883.5317281840635;895.417978314101;902.3457992955055;8234.01191856969;8680.088590698013;8731.781705457288;8732.563371831384;8831.735047948572;959.64972784933;976.6825781621002;985.4579981010415;987.456898705709;995.5320999130397;4813.326134341195;5382.327209098863;5459.454054594509;5506.697131657797;5564.749586268627;21175.78824211738;21748.347549573537;22069.227577034726;22082.779172208393;22196.334109976728;21508.569828603653;21691.349259522238;21790.782092179194;21820.15794511796;21938;10961.177911656658;11401.087912966943;11441.54233830654;11461.942690286494;11608.593699220486;8410.831783364176;8496.1079086695;8541.786455338666;8547.8717819234;8622.180892815173;18750.71873921865;19027.33404330842;19050.142743576296;19325.226990920204;19421.320253791615;19650;19831.40505784829;20054.799452005293;20065.59868802645;20196;11080.445977700922;11140.220184587;11288.153388495732;11290.379029153148;11321.660350189508;13792.793108103186;13982.370793314121;14018.859811402164;14047.578572642837;14063.648408789863;11064.22550421495;11158.10735141203;11405.144614153805;11431.885681143081;11437;11216.158788091088;11333;11371.31772093677;11460.770784584094;11529.1929564933;9543.0456954304;9737.221022318055;9750.073742994404;9769.2673049523;9808.901910981085;7400.629968501661;7445.255474452511;7475.215102414386;7534.811629709082;7574.3183113520045;7536.0956685198125;7593.468457207942;7669.079710434784;7674.347680447225;7693.884591731016 13:46:44 INFO - PID 16198 | |4;prototype.html;468.48934661219266;515.7318194538839;517.5471462470339;520.095034639727;520.310588470277;6153.5077193824445;6171.9382806171925;6177.691115444221;6182.9381706182985;6187.845303867405;6019.719253007111;6058.1518587397795;6079.848003799907;6105.664188469633;6121;5055.51972562606;5081.720505372203;5108.131617624994;5109.576583688938;5118.232265160219;4714.151452738506;4918.458969513351;5000.19996800512;5072.923906141411;5120.564751996066;4819.566119109844;4825.855224343275;4846.369971903648;4873.756312184377;4874.439439464471;4766.285057241407;4790.736509491977;4791.377120974251;4828.73441960692;4883.1942729449775;4323.805428755713;4327.204210252741;4372.256716358195;4404.4494438195225;4426.468823741139;5904.143899134644;5930.229070220844;5956.940430595725;5988.7604495820115;5994.430529099772;5569.275994120739;5575.330960284751;5607.859803504904;5638.323401191842;5647.152927060933;6509.121268628769;6511.902321465182;6523.967380163116;6535.934640653581;6543.901841472334;4806.855794326176;4818.650777782192;4823.421189457253;4830.178869592142;4831.4926932671915;6596.241432235306;6728.932710672929;6731.206549282091;6745.998030876262;6780.8304792380095;4842.951570484321;4925.596205081534;4929;4932.950670493249;4941.703497790144;4995.200767877195;4996.525330093636;5009.373828271466;5015.724135172601;5025.321581586439;5569.610127291132;5601.579881508903;5606.887862242814;5608.915866262009;5610.018246806792;6524.543281970311;6539.836504087436;6543;6548;6567;1736.270766278166;1743.476956912921;1745.3106023120797;1747.9475615731549;1747.9563010924828;1139.3391832736993;1207.2575366149931;1212.1030437476204;1212.921160124589;1218.3299185447968;5645.943540564624;5656.462636049569;5672.773089076473;5691.317041954909;5707.258056452634;6537.5750576212395;6610.173728283965;6610.570312929644;6617.86764264712;6628.83427914306;5492.313460817398;5587.497125258747;5610.102383618601;5613.803516876889;5639.548836093103;3446.6208717041104;3474.1488335358;3484.982575087108;3485.320362529333;3502.9299414011575;6341.936580634135;6345.206849143857;6361.141245931833;6373.139626150503;6431.360003199155;6707.0610114584;6712.194536655633;6796.898046529306;6819.215790184093;6829.214640316328;6415.935840641627;6422.197225346832;6432.06735023419;6434.131392261985;6463.612183268925;5953.166556681981;6424.164858568356;6616.569922954993;6627.37039981201;6639.571125794789;6483.546151769519;6550.213974323112;6568.277489476058;6593.901091483727;6607.372299631527;6231.189945307081;6305.274893387319;6334.714937827716;6413.4869210463985;6438.098666186831;4866.099771542276;4895.363602731622;4902.044101400193;4916.262560615936;4940.92588611164;6397.744090236339;6538.738450462119;6544.3311955452955;6662.866742665023;6681.164854393201;6197.504199663926;6336.714847831767;6360.268569114426;6371.93628063732;6376.840578985377;6322.873542529215;6354.633753742967;6371.776987805404;6425.935740642721;6442.162518872704;6284.622922624657;6301.149344838572;6339.714712837841;6349.7142628580905;6385.329540398191;6403.96798016007;6404.231492220963;6426.550141490051;6443.226812782309;6469.353064693493;6209.254889413119;6253.749850006131;6284.937150628618;6292.559520833681;6357.1735674362035 13:46:44 INFO - PID 16198 | |5;yui.html;851.4082712514801;886.1979908183097;887.9911200887989;898.2679116520036;927.0914503786289;18340.266389344426;18934.337298194583;18941.14764835582;18955.52611184721;18983;18298.817011829877;18424.723629145574;18463.169157387918;18612;18633.440996770118;933.5099072986668;944.1219665710886;944.36255527519;948.0235357581702;949.9952500237489;960.0303693269778;964.5129209749067;965.3869792681662;966.3911735606558;968.5544649461257;979.6718099436697;1012.2559918459926;1017.7506510904839;1017.9440130792804;1019.0319196763068;1004.3321191407705;1008.1430783833756;1008.7931973945324;1008.9495525223746;1012.8480727890839;752.1763668782675;752.2515097478044;752.3454594502817;752.5522314223083;753.2618034326337;17642.91178544112;17878.463646090637;18033.639327213514;19668.40994770145;20102.597948041104;21359.359219223294;21423.57152856934;21858.781412185832;21871.453213669625;21918.671219931715;17082.487525374258;17479.38822141219;17563.824361756346;17583.560410989827;17680.115994200238;3581.6418358163974;3613.5663720353464;3617.656322649344;3623.981880090609;3624.075860655516;107772;115447;145239;149839;151532;16688.415905443253;17223.56941076483;17325;17355.13224338778;17406.738898916527;30696.232594185323;31305;31505.8424707875;31521;31614.367712645617;8817;8855.690050848189;8873.911260887438;8891.510966896753;8899.777505562413;4149.792510374469;4201.369794530845;4307.978460107742;4309.202797482476;4312.116016216668;5413;5438.782448702087;5458.4814442627885;5470.890582188334;5501.477359650827;1075.4300220882944;1118.1166878166157;1125.983110253347;1126.7126882644873;1128.9266197697123;660.8513084555937;665.8002599220215;678.2844099475101;683.8358793889431;689.7654797368818;11604;11709.355985420883;12104;12794.232346059267;12807.231566106064;678.9422899053537;682.7200847652538;687.7077242172057;690.0752990992095;705.1291654806311;5630.268065151504;5667.037811874323;5735.512481439041;5783.277090363705;5840.123981402823;116438.41780791042;118217.40891295488;118828;120272.39863800626;122273;106050;106752.46623766831;107158.46420767847;107419;109689.45155274172;93701.5314923421;94526;96636;97824.51087744515;98440.50779746055;10722.19583531254;10793.784124317626;10821.242513024014;10924.2899211551;11033.944830275797;43193.35209971916;43445.348319774595;43819.34270985874;44615.77692111519;45185.32222016738;56843.431565683815;57974.420255796904;58168.4183158163;59168.40831591629;59929;16021.679566408373;16360.590985224988;16418.507444776675;16626.66746665084;16649.167541623112;16413.67172656564;16510;16631.83368166303;16640.251188696297;16764.832351676327;14624.634384140481;14769.630759231106;14791.778123328373;14875.181864997528;14980.250987450367;15855.286512106752;15900.602484937968;15950.68098638044;16010.519684409486;16156.838431616003;15359.692806144038;15375.76936345978;15378.538643840702;15489.380424782883;15618.609534761721;10712.35725856451;10881.782364352826;10924.50839712199;10944.124470042536;11265.831012534654;11338.185890257519;11351;11411.201215914807;11500.482478288664;11517.424128793695 13:46:44 INFO - PID 16198 | __end_tp_report 13:46:44 INFO - PID 16198 | __start_cc_report 13:46:44 INFO - PID 16198 | _x_x_mozilla_cycle_collect,364 13:46:44 INFO - PID 16198 | __end_cc_report 13:46:44 INFO - PID 16198 | __startTimestamp1505508404869__endTimestamp 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | ------- Summary: start ------- 13:46:44 INFO - PID 16198 | Number of tests: 6 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#0] dojo.html Cycles:165 Average:6114.78 Median:6435.20 stddev:847.10 (13.2%) stddev-sans-first:815.27 13:46:44 INFO - PID 16198 | Values: 3067.8 3076.0 3088.1 3092.7 3112.2 5992.5 6042.4 6088.5 6095.6 6158.4 6161.4 6199.0 6276.1 6277.0 6282.8 5740.1 5743.9 5861.6 5862.5 5873.1 5770.2 5828.8 5857.0 5890.1 5940.9 977.0 5294.2 5681.0 5767.9 5807.3 5711.2 5735.2 5803.1 5814.2 5828.7 5704.6 5741.5 5802.0 5805.6 5805.8 6203.8 6224.0 6235.7 6287.7 6292.0 6603.2 6637.8 6647.2 6736.8 6778.3 6468.7 6540.2 6542.1 6544.2 6548.6 6091.7 6150.4 6168.7 6170.1 6173.8 6758.5 6807.1 6851.0 6929.5 6968.7 6584.0 6646.7 6666.4 6670.2 6674.4 6682.5 6714.1 6714.3 6781.1 6803.6 6500.9 6580.6 6606.5 6612.0 6617.1 6554.0 6586.6 6650.5 6652.0 6655.0 5150.4 5215.8 5216.0 5220.6 5224.6 4509.4 4540.3 4540.9 4549.7 4557.9 5671.7 5685.3 5740.5 5755.3 5759.0 6768.8 6782.2 6783.2 6784.7 6793.9 5771.2 5776.3 5837.1 5851.8 5853.4 5748.0 5749.4 5823.8 5825.7 5835.1 6264.2 6376.6 6466.7 6554.0 6571.6 6761.9 6792.0 6793.5 6794.6 6811.2 6460.6 6463.5 6467.6 6538.3 6561.1 6374.3 6551.6 6556.8 6656.0 6658.6 6655.7 6713.3 6783.5 6793.1 6795.3 6565.7 6573.2 6574.3 6589.8 6604.2 6479.4 6483.3 6514.5 6588.4 6602.6 6274.4 6392.0 6473.4 6482.9 6488.8 6503.4 6528.3 6549.1 6556.3 6634.6 6354.9 6360.8 6370.1 6435.2 6450.7 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#1] ext.html Cycles:180 Average:37499.24 Median:19561.11 stddev:53404.18 (273.0%) stddev-sans-first:53482.95 13:46:44 INFO - PID 16198 | Values: 812.9 837.0 847.9 861.8 864.2 40450.8 41268.2 41280.8 41287.4 41728.6 38344.6 40905.2 41407.8 41438.6 41469.8 7653.1 7769.4 7777.2 7789.4 7791.1 7585.8 7678.9 7698.8 7706.3 7709.5 7708.6 7722.4 7731.1 7738.8 7739.8 7668.0 7671.0 7687.6 7713.0 7719.1 7563.5 7598.1 7608.3 7610.0 7611.8 37021.8 37154.4 37234.0 37443.0 37595.8 3526.8 3560.2 3572.6 3601.3 3603.5 30737.8 30833.7 30843.5 30844.7 30858.8 5007.4 5131.6 5133.9 5154.9 5173.7 186503.0 187502.0 188597.1 190474.0 199197.0 48018.0 48113.8 48481.8 48516.0 48585.3 50438.0 50455.2 50456.7 50563.2 50573.5 15825.6 15868.6 15994.0 16005.2 16103.1 13219.1 13310.3 13329.9 13346.3 13360.5 12866.2 12887.9 13010.5 13113.5 13128.7 5298.7 5379.5 5391.1 5391.5 5393.6 998.7 1012.9 1014.1 1026.0 1039.7 22776.2 22872.8 22954.7 23139.6 23493.5 1088.5 1099.5 1109.6 1114.1 1114.7 11967.8 12076.4 12143.8 12183.6 12240.8 229682.0 230048.0 230269.0 230815.0 231441.0 52440.5 52608.5 52864.2 57719.0 58007.4 1409.7 1460.1 1461.2 1470.2 1474.0 28130.4 28218.2 28380.0 28486.6 28915.9 34009.5 37355.0 38145.6 38204.4 38332.4 192390.0 195423.0 195635.0 195887.0 196371.0 31533.2 31966.8 32133.0 32998.8 35060.0 43022.6 43448.1 43605.0 43765.0 43970.6 31924.7 31935.0 32163.7 32331.2 32744.7 31568.4 31818.0 31938.5 32073.2 33004.5 35595.5 35837.3 35994.3 35994.3 36091.5 30745.0 30748.7 31260.4 31365.4 31508.8 22187.9 22218.2 22770.4 23111.8 23120.4 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#2] jquery.html Cycles:180 Average:34075.90 Median:22416.61 stddev:81941.88 (365.5%) stddev-sans-first:82133.11 13:46:44 INFO - PID 16198 | Values: 563.9 564.0 565.2 567.5 602.6 22017.8 22790.5 22801.2 22810.4 22826.8 23360.4 24084.9 24498.9 24703.8 24808.4 6373.6 6469.5 6495.7 6506.2 6506.3 6366.2 6468.5 6469.6 6472.0 6472.3 6335.4 6390.3 6600.3 6600.5 6615.6 6616.7 6666.3 6671.9 6674.4 6675.9 6148.4 6156.0 6157.9 6160.5 6169.6 27018.5 27686.9 28142.9 28295.4 28330.0 1996.7 2031.5 2033.1 2036.8 2042.8 19326.5 19644.1 19657.1 19659.3 19682.7 2359.9 2419.6 2429.6 2431.8 2508.9 116136.0 121872.0 129619.0 132785.3 135383.3 14298.6 14465.3 14644.0 14708.0 14709.6 22313.6 22333.6 22337.0 22401.3 22431.9 9628.2 10167.7 10168.7 10303.5 10318.9 9405.5 9457.6 9505.0 9641.7 9677.1 8582.3 8751.0 8900.0 8902.8 8921.6 2620.6 2633.7 2675.1 2710.9 2723.2 935.3 960.6 969.3 969.5 971.4 18731.6 19189.1 19433.3 19463.7 19500.0 1018.4 1031.4 1033.4 1047.9 1053.3 10519.0 10532.3 10674.6 10864.2 10915.5 473068.0 487620.0 487718.0 491704.0 504991.0 107568.2 110012.4 110641.4 110676.4 111461.0 1030.1 1075.1 1145.6 1170.1 1189.2 20018.9 20037.1 20056.4 20066.4 20449.5 53483.5 55460.6 55630.0 55653.4 56626.2 69676.7 70451.0 70466.0 70919.0 72256.6 13914.4 14237.1 14316.0 14405.7 14415.8 22362.3 22399.1 22472.1 22500.9 22628.4 17199.6 17957.1 18504.4 18522.2 18534.2 15675.9 16083.1 16150.4 16464.5 16551.1 17829.5 18443.9 18500.4 18503.4 18573.8 14047.2 14055.9 14057.2 14127.2 14144.4 17561.6 17710.1 17894.0 18038.8 18071.6 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#3] mootools.html Cycles:180 Average:9490.18 Median:2794.34 stddev:6699.35 (239.7%) stddev-sans-first:6690.24 13:46:44 INFO - PID 16198 | Values: 1351.6 1395.4 1397.8 1402.4 1409.1 14961.3 15610.8 15624.5 15635.9 15654.4 15183.5 15329.6 15329.7 15353.2 15370.6 2770.8 2812.7 2873.5 2879.5 2879.8 2789.8 2800.4 2817.8 2818.1 2818.3 2672.5 2779.5 2876.8 2878.8 2880.3 2812.2 2834.7 2885.0 2887.4 2887.8 2773.5 2787.5 2798.8 2815.7 2827.1 15051.8 15159.4 15287.3 15292.8 15299.5 8121.9 8402.3 8406.5 8422.6 8438.4 5437.2 5586.0 5732.8 5763.5 5803.3 1856.5 1879.9 1890.5 1921.6 1933.1 25991.0 26229.7 26278.3 26298.2 26333.9 6878.0 6880.6 6893.0 7075.5 7131.5 16745.3 17076.0 17107.7 17132.0 17143.3 8047.8 8329.0 8579.4 8612.6 8624.5 7640.8 7650.7 7653.8 7656.8 7677.8 5060.0 5182.5 5185.6 5200.9 5208.0 1436.5 1441.4 1537.8 1585.8 1588.0 858.7 875.4 883.5 895.4 902.3 8234.0 8680.1 8731.8 8732.6 8831.7 959.6 976.7 985.5 987.5 995.5 4813.3 5382.3 5459.5 5506.7 5564.7 21175.8 21748.3 22069.2 22082.8 22196.3 21508.6 21691.3 21790.8 21820.2 21938.0 10961.2 11401.1 11441.5 11461.9 11608.6 8410.8 8496.1 8541.8 8547.9 8622.2 18750.7 19027.3 19050.1 19325.2 19421.3 19650.0 19831.4 20054.8 20065.6 20196.0 11080.4 11140.2 11288.2 11290.4 11321.7 13792.8 13982.4 14018.9 14047.6 14063.6 11064.2 11158.1 11405.1 11431.9 11437.0 11216.2 11333.0 11371.3 11460.8 11529.2 9543.0 9737.2 9750.1 9769.3 9808.9 7400.6 7445.3 7475.2 7534.8 7574.3 7536.1 7593.5 7669.1 7674.3 7693.9 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#4] prototype.html Cycles:180 Average:5416.28 Median:6007.07 stddev:1515.06 (25.2%) stddev-sans-first:1473.09 13:46:44 INFO - PID 16198 | Values: 468.5 515.7 517.5 520.1 520.3 6153.5 6171.9 6177.7 6182.9 6187.8 6019.7 6058.2 6079.8 6105.7 6121.0 5055.5 5081.7 5108.1 5109.6 5118.2 4714.2 4918.5 5000.2 5072.9 5120.6 4819.6 4825.9 4846.4 4873.8 4874.4 4766.3 4790.7 4791.4 4828.7 4883.2 4323.8 4327.2 4372.3 4404.4 4426.5 5904.1 5930.2 5956.9 5988.8 5994.4 5569.3 5575.3 5607.9 5638.3 5647.2 6509.1 6511.9 6524.0 6535.9 6543.9 4806.9 4818.7 4823.4 4830.2 4831.5 6596.2 6728.9 6731.2 6746.0 6780.8 4843.0 4925.6 4929.0 4933.0 4941.7 4995.2 4996.5 5009.4 5015.7 5025.3 5569.6 5601.6 5606.9 5608.9 5610.0 6524.5 6539.8 6543.0 6548.0 6567.0 1736.3 1743.5 1745.3 1747.9 1748.0 1139.3 1207.3 1212.1 1212.9 1218.3 5645.9 5656.5 5672.8 5691.3 5707.3 6537.6 6610.2 6610.6 6617.9 6628.8 5492.3 5587.5 5610.1 5613.8 5639.5 3446.6 3474.1 3485.0 3485.3 3502.9 6341.9 6345.2 6361.1 6373.1 6431.4 6707.1 6712.2 6796.9 6819.2 6829.2 6415.9 6422.2 6432.1 6434.1 6463.6 5953.2 6424.2 6616.6 6627.4 6639.6 6483.5 6550.2 6568.3 6593.9 6607.4 6231.2 6305.3 6334.7 6413.5 6438.1 4866.1 4895.4 4902.0 4916.3 4940.9 6397.7 6538.7 6544.3 6662.9 6681.2 6197.5 6336.7 6360.3 6371.9 6376.8 6322.9 6354.6 6371.8 6425.9 6442.2 6284.6 6301.1 6339.7 6349.7 6385.3 6404.0 6404.2 6426.6 6443.2 6469.4 6209.3 6253.7 6284.9 6292.6 6357.2 13:46:44 INFO - PID 16198 | 13:46:44 INFO - PID 16198 | [#5] yui.html Cycles:180 Average:23988.75 Median:18537.58 stddev:34656.59 (187.0%) stddev-sans-first:34710.27 13:46:44 INFO - PID 16198 | Values: 851.4 886.2 888.0 898.3 927.1 18340.3 18934.3 18941.1 18955.5 18983.0 18298.8 18424.7 18463.2 18612.0 18633.4 933.5 944.1 944.4 948.0 950.0 960.0 964.5 965.4 966.4 968.6 979.7 1012.3 1017.8 1017.9 1019.0 1004.3 1008.1 1008.8 1008.9 1012.8 752.2 752.3 752.3 752.6 753.3 17642.9 17878.5 18033.6 19668.4 20102.6 21359.4 21423.6 21858.8 21871.5 21918.7 17082.5 17479.4 17563.8 17583.6 17680.1 3581.6 3613.6 3617.7 3624.0 3624.1 107772.0 115447.0 145239.0 149839.0 151532.0 16688.4 17223.6 17325.0 17355.1 17406.7 30696.2 31305.0 31505.8 31521.0 31614.4 8817.0 8855.7 8873.9 8891.5 8899.8 4149.8 4201.4 4308.0 4309.2 4312.1 5413.0 5438.8 5458.5 5470.9 5501.5 1075.4 1118.1 1126.0 1126.7 1128.9 660.9 665.8 678.3 683.8 689.8 11604.0 11709.4 12104.0 12794.2 12807.2 678.9 682.7 687.7 690.1 705.1 5630.3 5667.0 5735.5 5783.3 5840.1 116438.4 118217.4 118828.0 120272.4 122273.0 106050.0 106752.5 107158.5 107419.0 109689.5 93701.5 94526.0 96636.0 97824.5 98440.5 10722.2 10793.8 10821.2 10924.3 11033.9 43193.4 43445.3 43819.3 44615.8 45185.3 56843.4 57974.4 58168.4 59168.4 59929.0 16021.7 16360.6 16418.5 16626.7 16649.2 16413.7 16510.0 16631.8 16640.3 16764.8 14624.6 14769.6 14791.8 14875.2 14980.3 15855.3 15900.6 15950.7 16010.5 16156.8 15359.7 15375.8 15378.5 15489.4 15618.6 10712.4 10881.8 10924.5 10944.1 11265.8 11338.2 11351.0 11411.2 11500.5 11517.4 13:46:44 INFO - PID 16198 | -------- Summary: end -------- 13:46:44 INFO - PID 16198 | 13:46:45 INFO - TEST-INFO | 16198: exit 0 13:46:45 INFO - TEST-OK | dromaeo_css | took 1109130ms 13:46:45 INFO - TEST-START | kraken 13:46:45 INFO - Initialising browser for kraken test... 13:46:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60951/getInfo.html -profile /tmp/tmpOAlwaW/profile 13:46:45 INFO - TEST-INFO | started process 16568 (/builds/slave/test/build/application/firefox/firefox http://localhost:60951/getInfo.html) 13:46:50 INFO - TEST-INFO | 16568: exit 0 13:46:51 INFO - Browser initialized. 13:46:51 INFO - Running cycle 1/1 for kraken test... 13:46:51 INFO - Using env: {'DISPLAY': ':0', 13:46:51 INFO - 'HOME': '/home/cltbld', 13:46:51 INFO - 'JSGC_DISABLE_POISONING': '1', 13:46:51 INFO - 'LANG': 'en_US.UTF-8', 13:46:51 INFO - 'LANGUAGE': 'en_US:en', 13:46:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:46:51 INFO - 'LOGNAME': 'cltbld', 13:46:51 INFO - 'MAIL': '/var/mail/cltbld', 13:46:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:46:51 INFO - 'MOZ_CRASHREPORTER': '1', 13:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:46:51 INFO - 'MOZ_NO_REMOTE': '1', 13:46:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:46:51 INFO - 'NO_EM_RESTART': '1', 13:46:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:51 INFO - 'PWD': '/builds/slave/test', 13:46:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:51 INFO - 'RUST_BACKTRACE': 'full', 13:46:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:46:51 INFO - 'SHELL': '/bin/bash', 13:46:51 INFO - 'SHLVL': '1', 13:46:51 INFO - 'TERM': 'linux', 13:46:51 INFO - 'TMOUT': '86400', 13:46:51 INFO - 'USER': 'cltbld', 13:46:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751', 13:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:51 INFO - '_': '/tools/buildbot/bin/python'} 13:46:51 INFO - TEST-INFO | started process 16802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOAlwaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:51 INFO - PID 16802 | 13:46:51 INFO - PID 16802 | (/builds/slave/test/build/application/firefox/firefox:16851): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:46:51 INFO - PID 16802 | 13:47:02 INFO - PID 16802 | RSS: Main: 173830144 13:47:02 INFO - PID 16802 | 13:47:05 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60951/tests/kraken/driver.html?testName=audio-beat-detection) 13:47:05 INFO - PID 16802 | RSS: Main: 179429376 13:47:05 INFO - PID 16802 | 13:47:08 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60951/tests/kraken/driver.html?testName=audio-dft) 13:47:09 INFO - PID 16802 | RSS: Main: 179748864 13:47:09 INFO - PID 16802 | 13:47:12 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60951/tests/kraken/driver.html?testName=audio-fft) 13:47:12 INFO - PID 16802 | RSS: Main: 174362624 13:47:12 INFO - PID 16802 | 13:47:14 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60951/tests/kraken/driver.html?testName=audio-oscillator) 13:47:15 INFO - PID 16802 | RSS: Main: 174907392 13:47:15 INFO - PID 16802 | 13:47:17 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60951/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:18 INFO - PID 16802 | RSS: Main: 175198208 13:47:18 INFO - PID 16802 | 13:47:21 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60951/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:22 INFO - PID 16802 | RSS: Main: 178147328 13:47:22 INFO - PID 16802 | 13:47:25 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60951/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:26 INFO - PID 16802 | RSS: Main: 178143232 13:47:26 INFO - PID 16802 | 13:47:29 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60951/tests/kraken/driver.html?testName=json-parse-financial) 13:47:30 INFO - PID 16802 | RSS: Main: 178253824 13:47:30 INFO - PID 16802 | 13:47:31 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60951/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:32 INFO - PID 16802 | RSS: Main: 178192384 13:47:32 INFO - PID 16802 | 13:47:33 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:34 INFO - PID 16802 | RSS: Main: 178094080 13:47:34 INFO - PID 16802 | 13:47:36 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:37 INFO - PID 16802 | RSS: Main: 175116288 13:47:37 INFO - PID 16802 | 13:47:39 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:40 INFO - PID 16802 | RSS: Main: 175693824 13:47:40 INFO - PID 16802 | 13:47:43 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:44 INFO - PID 16802 | RSS: Main: 175382528 13:47:44 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | Cycle 1(1): loaded http://localhost:60951/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60951/tests/kraken/driver.html?testName=ai-astar) 13:47:46 INFO - PID 16802 | RSS: Main: 176816128 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | __start_tp_report 13:47:46 INFO - PID 16802 | _x_x_mozilla_page_load 13:47:46 INFO - PID 16802 | _x_x_mozilla_page_load_details 13:47:46 INFO - PID 16802 | |i|pagename|runs| 13:47:46 INFO - PID 16802 | |0;ai-astar;112;109;108;107;110;109;108;108;107;108 13:47:46 INFO - PID 16802 | |1;audio-beat-detection;117;118;117;140;118;140;167;116;119;116 13:47:46 INFO - PID 16802 | |2;audio-dft;162;162;163;162;162;164;169;170;164;163 13:47:46 INFO - PID 16802 | |3;audio-fft;75;74;74;74;73;75;78;76;74;74 13:47:46 INFO - PID 16802 | |4;audio-oscillator;80;79;79;79;79;79;79;80;81;79 13:47:46 INFO - PID 16802 | |5;imaging-gaussian-blur;114;113;113;114;115;114;114;117;117;116 13:47:46 INFO - PID 16802 | |6;imaging-darkroom;148;148;147;148;150;150;148;149;149;148 13:47:46 INFO - PID 16802 | |7;imaging-desaturate;97;94;94;94;94;94;93;94;94;94 13:47:46 INFO - PID 16802 | |8;json-parse-financial;54;52;54;55;55;55;55;54;55;53 13:47:46 INFO - PID 16802 | |9;json-stringify-tinderbox;38;39;37;38;38;39;38;38;38;38 13:47:46 INFO - PID 16802 | |10;stanford-crypto-aes;74;73;74;78;77;79;77;76;74;74 13:47:46 INFO - PID 16802 | |11;stanford-crypto-ccm;120;111;118;119;114;116;116;116;115;115 13:47:46 INFO - PID 16802 | |12;stanford-crypto-pbkdf2;173;169;173;182;167;172;167;165;171;166 13:47:46 INFO - PID 16802 | |13;stanford-crypto-sha256-iterative;71;65;64;64;64;70;67;73;76;67 13:47:46 INFO - PID 16802 | __end_tp_report 13:47:46 INFO - PID 16802 | __start_cc_report 13:47:46 INFO - PID 16802 | _x_x_mozilla_cycle_collect,947 13:47:46 INFO - PID 16802 | __end_cc_report 13:47:46 INFO - PID 16802 | __startTimestamp1505508466356__endTimestamp 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | ------- Summary: start ------- 13:47:46 INFO - PID 16802 | Number of tests: 14 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#0] ai-astar Cycles:10 Average:108.60 Median:108.50 stddev:1.51 (1.4%) stddev-sans-first:0.97 13:47:46 INFO - PID 16802 | Values: 112.0 109.0 108.0 107.0 110.0 109.0 108.0 108.0 107.0 108.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:118.50 stddev:17.02 (14.4%) stddev-sans-first:17.67 13:47:46 INFO - PID 16802 | Values: 117.0 118.0 117.0 140.0 118.0 140.0 167.0 116.0 119.0 116.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.96 (1.8%) stddev-sans-first:3.04 13:47:46 INFO - PID 16802 | Values: 162.0 162.0 163.0 162.0 162.0 164.0 169.0 170.0 164.0 163.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#3] audio-fft Cycles:10 Average:74.70 Median:74.50 stddev:1.42 (1.9%) stddev-sans-first:1.50 13:47:46 INFO - PID 16802 | Values: 75.0 74.0 74.0 74.0 73.0 75.0 78.0 76.0 74.0 74.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 13:47:46 INFO - PID 16802 | Values: 80.0 79.0 79.0 79.0 79.0 79.0 79.0 80.0 81.0 79.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.49 (1.3%) stddev-sans-first:1.56 13:47:46 INFO - PID 16802 | Values: 114.0 113.0 113.0 114.0 115.0 114.0 114.0 117.0 117.0 116.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 13:47:46 INFO - PID 16802 | Values: 148.0 148.0 147.0 148.0 150.0 150.0 148.0 149.0 149.0 148.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.03 (1.1%) stddev-sans-first:0.33 13:47:46 INFO - PID 16802 | Values: 97.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.09 13:47:46 INFO - PID 16802 | Values: 54.0 52.0 54.0 55.0 55.0 55.0 55.0 54.0 55.0 53.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 13:47:46 INFO - PID 16802 | Values: 38.0 39.0 37.0 38.0 38.0 39.0 38.0 38.0 38.0 38.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:76.50 stddev:2.07 (2.7%) stddev-sans-first:2.11 13:47:46 INFO - PID 16802 | Values: 74.0 73.0 74.0 78.0 77.0 79.0 77.0 76.0 74.0 74.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:116.00 stddev:2.58 (2.2%) stddev-sans-first:2.30 13:47:46 INFO - PID 16802 | Values: 120.0 111.0 118.0 119.0 114.0 116.0 116.0 116.0 115.0 115.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:4.99 (2.9%) stddev-sans-first:5.21 13:47:46 INFO - PID 16802 | Values: 173.0 169.0 173.0 182.0 167.0 172.0 167.0 165.0 171.0 166.0 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:4.23 (6.2%) stddev-sans-first:4.35 13:47:46 INFO - PID 16802 | Values: 71.0 65.0 64.0 64.0 64.0 70.0 67.0 73.0 76.0 67.0 13:47:46 INFO - PID 16802 | -------- Summary: end -------- 13:47:46 INFO - PID 16802 | 13:47:46 INFO - PID 16802 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:47:47 INFO - TEST-INFO | 16802: exit 0 13:47:47 INFO - TEST-OK | kraken | took 61486ms 13:47:47 INFO - SUITE-END | took 1170s 13:47:47 INFO - Completed test suite (00:19:31) 13:47:47 INFO - javascript benchmark 13:47:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8459.971718818157, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.785255032146, 3075.9846200769, 3088.089013740947, 3092.7061929116726, 3112.1752735525088, 5992.490638295744, 6042.425969532887, 6088.543359248052, 6095.634261944281, 6158.414950579693, 6161.414665606771, 6199.039148931912, 6276.121343011982, 6276.968615156929, 6282.780102696406, 5740.081586946089, 5743.856403589902, 5861.58968872177, 5862.530997520188, 5873.148393482942, 5770.2210201622665, 5828.825135245949, 5857.033589457735, 5890.057590785475, 5940.88118237635, 976.9725325999016, 5294.232336311233, 5681.034224181878, 5767.88464230713, 5807.274090738658, 5711.171880077365, 5735.1970724098655, 5803.129530570406, 5814.215080964101, 5828.737706803204, 5704.629199102045, 5741.511971482387, 5801.970990145022, 5805.622634528784, 5805.796797112123, 6203.782867599657, 6223.968880155616, 6235.688215589248, 6287.654179020152, 6292.0, 6603.240627327823, 6637.800865974028, 6647.235567909655, 6736.797896063126, 6778.322167783232, 6468.741250350027, 6540.247871494791, 6542.051402546652, 6544.247411547685, 6548.607083574953, 6091.664958427285, 6150.354212807635, 6168.722407491674, 6170.136180934673, 6173.783917562909, 6758.493113016445, 6807.115075040213, 6851.006604042386, 6929.549579277331, 6968.721251149897, 6584.012398140318, 6646.6676666166495, 6666.366695163952, 6670.166229221348, 6674.432673222734, 6682.498812589075, 6714.060031595581, 6714.29499902513, 6781.084553585301, 6803.591784492946, 6500.869982600321, 6580.605163690194, 6606.504512161511, 6611.966940165268, 6617.073609694647, 6553.967230163818, 6586.6377349245295, 6650.53446258767, 6651.966740166365, 6655.0, 5150.4334523202415, 5215.817446389434, 5216.035033518811, 5220.5823534117935, 5224.555912747459, 4509.413776209138, 4540.318952157137, 4540.88647783808, 4549.658775591844, 4557.908841823145, 5671.659700417906, 5685.260916080966, 5740.512056475163, 5755.280589926259, 5759.0, 6768.830779230559, 6782.152230971129, 6783.18601767791, 6784.6946887389195, 6793.864122717617, 5771.192033115367, 5776.306843178845, 5837.09525023622, 5851.824445266649, 5853.385394533598, 5747.971260143672, 5749.396313387034, 5823.796167134215, 5825.679587622722, 5835.066389377679, 6264.21697287839, 6376.617402955838, 6466.741330346734, 6553.984132459476, 6571.572847764975, 6761.932380676229, 6792.049113124167, 6793.490488213305, 6794.626295553792, 6811.2167100784045, 6460.612363258219, 6463.515236357386, 6467.611943283418, 6538.346165383424, 6561.081448597296, 6374.3306952771145, 6551.574147680385, 6556.803295901131, 6656.0348749430095, 6658.6337751424135, 6655.733770649314, 6713.328667133248, 6783.491238157059, 6793.116894803644, 6795.286494917962, 6565.737370505126, 6573.244076931214, 6574.276829548841, 6589.769358072444, 6604.174478190226, 6479.416852483299, 6483.286838447862, 6514.511411644051, 6588.4399826013405, 6602.603843769197, 6274.435300822765, 6391.96804015977, 6473.417392434515, 6482.902756458751, 6488.805335839932, 6503.447206987459, 6528.281888992112, 6549.115869357575, 6556.311587283458, 6634.635095069818, 6354.93645063562, 6360.77737279193, 6370.140031095742, 6435.195600549931, 6450.741970321134], "value": 6051.667119700203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.8983877015373, 837.0415873824471, 847.8855354527141, 861.7931696392867, 864.209248537588, 40450.79774601127, 41268.174636507254, 41280.79359603202, 41287.38068928968, 41728.58271417285, 38344.61655383445, 40905.18189636205, 41407.79296103523, 41438.58561414385, 41469.792651036776, 7653.0816302043695, 7769.417293702967, 7777.222277772205, 7789.4157938154585, 7791.065072191345, 7585.848283034336, 7678.923210767876, 7698.807529811772, 7706.306432421081, 7709.498882572615, 7708.57602831844, 7722.382209423261, 7731.072271327449, 7738.806529836743, 7739.7678069658, 7668.0, 7671.0, 7687.615619219045, 7712.961435192844, 7719.073711154641, 7563.508371955805, 7598.126215485179, 7608.277213664693, 7610.0, 7611.809704757426, 37021.81489092537, 37154.44268335977, 37234.0, 37443.0, 37595.81202093972, 3526.7531272810916, 3560.2345495718546, 3572.5712914450173, 3601.2797440512004, 3603.531540899666, 30737.846310768302, 30833.691663083308, 30843.53734693959, 30844.691553084405, 30858.845705771553, 5007.37407824022, 5131.615128865313, 5133.948660513384, 5154.92267615986, 5173.715445650488, 186503.0, 187502.0, 188597.05701471542, 190474.0, 199197.0, 48018.0, 48113.75943120262, 48481.757591212525, 48516.0, 48585.27122093172, 50438.0, 50455.24317135246, 50456.74771626118, 50563.241551376756, 50573.49426505688, 15825.604359891095, 15868.603284917739, 15994.0, 16005.199740012953, 16103.1143287118, 13219.140755851031, 13310.334483275798, 13329.866701333056, 13346.332683365792, 13360.465581376831, 12866.163699359511, 12887.871121288666, 13010.544630937871, 13113.541026064042, 13128.737425251442, 5298.735063246822, 5379.515843574097, 5391.056565101092, 5391.514763671288, 5393.5954803389905, 998.650472334677, 1012.8733908261468, 1014.0974532665933, 1025.9846102308472, 1039.7244730146517, 22776.2028329011, 22872.7712722874, 22954.65568016481, 23139.611623302655, 23493.530129397317, 1088.4666513408372, 1099.4777480696605, 1109.5949978258038, 1114.1309778372881, 1114.726891911487, 11967.820482692767, 12076.430064091612, 12143.817842732366, 12183.573574925013, 12240.75518489643, 229682.0, 230048.0, 230269.0, 230815.0, 231441.0, 52440.47559524432, 52608.47391526112, 52864.20703689448, 57719.0, 58007.41992580105, 1409.654634614526, 1460.072853737884, 1461.2328527522923, 1470.1767010474168, 1474.0418727826784, 28130.43739125165, 28218.153455396372, 28380.0, 28486.57270140908, 28915.85542072276, 34009.48985765265, 37355.0, 38145.618543814206, 38204.42693359657, 38332.42501362426, 192390.0, 195423.0, 195635.0, 195887.0, 196371.0, 31533.211669708442, 31966.840165799953, 32133.0, 32998.83500582482, 35060.0, 43022.56977430185, 43448.13103737971, 43605.0, 43765.0, 43970.560294397925, 31924.68075319217, 31935.0, 32163.678363217005, 32331.19172020718, 32744.672553275115, 31568.36863262676, 31818.0, 31938.52092218665, 32073.198170045936, 33004.50493242651, 35595.466068008485, 35837.283254335285, 35994.28011439809, 35994.28011439809, 36091.458628120075, 30745.0, 30748.692513074584, 31260.374792504477, 31365.372692546476, 31508.842455787573, 22187.889060554593, 22218.222362217246, 22770.43073923165, 23111.76888231096, 23120.421989449726], "value": 17105.095393860123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9238702775124, 563.9887202255958, 565.1945976982798, 567.4989652369483, 602.6022824935542, 22017.779822201774, 22790.544189116208, 22801.201957931476, 22810.429739256528, 22826.771732282672, 23360.415989600267, 24084.879575602143, 24498.87750561249, 24703.75296247037, 24808.379790505245, 6373.649449280288, 6469.547131700783, 6495.707693153796, 6506.186726659168, 6506.284308726036, 6366.204224471941, 6468.482521398277, 6469.644169570672, 6472.0, 6472.288048314682, 6335.3981371769605, 6390.265119511246, 6600.339966003386, 6600.471962243009, 6615.569987950792, 6616.735330586771, 6666.333366663343, 6671.899921501205, 6674.432673222782, 6675.86648267032, 6148.354422785633, 6155.969220153916, 6157.876842463125, 6160.507159427235, 6169.629822210682, 27018.45963080747, 27686.86156569204, 28142.859285703442, 28295.434091318264, 28330.0, 1996.6805311150292, 2031.5022819409191, 2033.0851116997262, 2036.8370530357536, 2042.7650820155723, 19326.516837079045, 19644.11601477937, 19657.11542980555, 19659.311924082587, 19682.70475942862, 2359.858408495496, 2419.552382809168, 2429.5626787178303, 2431.8176136789634, 2508.94982100357, 116136.0, 121872.0, 129619.0, 132785.33607331998, 135383.3230833859, 14298.57104286873, 14465.291176123097, 14644.0, 14708.043977141666, 14709.55871323862, 22313.55372892533, 22333.55332893333, 22337.0, 22401.327960161223, 22431.887840560692, 9628.229741620653, 10167.694969150938, 10168.745781355525, 10303.536340864679, 10318.948405258076, 9405.482698451651, 9457.574409151604, 9505.0, 9641.662541811003, 9677.129058384779, 8582.313414926792, 8750.956245218733, 8899.955500222586, 8902.777430564287, 8921.598528066253, 2620.6241723095527, 2633.6839579250613, 2675.1305825606755, 2710.8780104895327, 2723.1694333228556, 935.3499317974079, 960.6157536985122, 969.2827307792325, 969.5055521683992, 971.358903123949, 18731.625367492845, 19189.136488858036, 19433.319833806032, 19463.708044379346, 19500.0, 1018.4398580780542, 1031.3811712972156, 1033.426448321189, 1047.9004494573003, 1053.3258714422775, 10519.0, 10532.262741608167, 10674.57301707923, 10864.158067706081, 10915.454227288605, 473068.0, 487620.0, 487718.0, 491704.0, 504991.0, 107568.23511177071, 110012.4499377498, 110641.44679276552, 110676.4466177664, 111461.0, 1030.1449796668746, 1075.086176749772, 1145.627671006926, 1170.0756402441975, 1189.1556994533978, 20018.89990550038, 20037.09833057545, 20056.398308050782, 20066.398008059783, 20449.48876278105, 53483.46516534785, 55460.60391895264, 55630.0, 55653.44346556483, 56626.15060774009, 69676.6516167416, 70451.0, 70466.0, 70919.0, 72256.63871680819, 13914.373853176834, 14237.074590151607, 14316.0, 14405.703486686249, 14415.78376324335, 22362.329130126123, 22399.104035838383, 22472.101115955178, 22500.887495562416, 22628.434289142246, 17199.57001074983, 17957.102144892964, 18504.444866654023, 18522.166502507687, 18534.16596253145, 15675.921620391826, 16083.115428651536, 16150.353985840435, 16464.506064818073, 16551.08969006716, 17829.46511604654, 18443.907780461013, 18500.444986650422, 18503.35238266654, 18573.81426185721, 14047.227402492961, 14055.929720351332, 14057.226852522801, 14127.223002734949, 14144.363503642566, 17561.648767024843, 17710.114494274978, 17894.0, 18038.819611803712, 18071.638567228845], "value": 11794.333618428076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.6012776231012, 1395.4209003263652, 1397.7763557830742, 1402.3549167383003, 1409.1474657832014, 14961.326740296685, 15610.76583851243, 15624.531264062069, 15635.921820390897, 15654.373825047012, 15183.544493665207, 15329.616759581017, 15329.69340613187, 15353.232338383092, 15370.615734606641, 2770.819896706718, 2812.7187281271913, 2873.454043731684, 2879.539273716206, 2879.812812167213, 2789.846558439285, 2800.4119134981574, 2817.7745780337523, 2818.112294627196, 2818.3236023354348, 2672.4788666210097, 2779.5413756730113, 2876.798624096314, 2878.8272703637745, 2880.2799300174956, 2812.2406950123554, 2834.6740124885696, 2884.956725649117, 2887.3647797484728, 2887.8267303961725, 2773.486904922596, 2787.4982503149427, 2798.8320700757818, 2815.7465828075365, 2827.067067867599, 15051.849481505154, 15159.393624255017, 15287.312070956834, 15292.770608440882, 15299.46451874179, 8121.878171827428, 8402.285805706522, 8406.453580517247, 8422.620982055822, 8438.36712246584, 5437.184422336642, 5585.972070139624, 5732.799352022701, 5763.5101016413655, 5803.346046376804, 1856.4709057918562, 1879.8590105741987, 1890.5368184794677, 1921.5868588253593, 1933.1011079847938, 25991.0, 26229.73770262292, 26278.343041424116, 26298.21105366842, 26333.868330658417, 6877.965610171917, 6880.621565813828, 6892.965535172392, 7075.540089894141, 7131.536450130725, 16745.330186792635, 17076.0, 17107.74338384925, 17131.97208167514, 17143.314267429414, 8047.798805029921, 8329.0, 8579.399442038997, 8612.5693715314, 8624.52565108925, 7640.808979775439, 7650.73222437212, 7653.770386888402, 7656.846863062708, 7677.846443071219, 5060.0, 5182.481751824863, 5185.585153187812, 5200.92198617021, 5208.0365132450615, 1436.4685066525244, 1441.358595425026, 1537.823150337703, 1585.8334874838206, 1588.0471716969726, 858.7252079334678, 875.3872289397448, 883.5317281840635, 895.417978314101, 902.3457992955055, 8234.01191856969, 8680.088590698013, 8731.781705457288, 8732.563371831384, 8831.735047948572, 959.64972784933, 976.6825781621002, 985.4579981010415, 987.456898705709, 995.5320999130397, 4813.326134341195, 5382.327209098863, 5459.454054594509, 5506.697131657797, 5564.749586268627, 21175.78824211738, 21748.347549573537, 22069.227577034726, 22082.779172208393, 22196.334109976728, 21508.569828603653, 21691.349259522238, 21790.782092179194, 21820.15794511796, 21938.0, 10961.177911656658, 11401.087912966943, 11441.54233830654, 11461.942690286494, 11608.593699220486, 8410.831783364176, 8496.1079086695, 8541.786455338666, 8547.8717819234, 8622.180892815173, 18750.71873921865, 19027.33404330842, 19050.142743576296, 19325.226990920204, 19421.320253791615, 19650.0, 19831.40505784829, 20054.799452005293, 20065.59868802645, 20196.0, 11080.445977700922, 11140.220184587, 11288.153388495732, 11290.379029153148, 11321.660350189508, 13792.793108103186, 13982.370793314121, 14018.859811402164, 14047.578572642837, 14063.648408789863, 11064.22550421495, 11158.10735141203, 11405.144614153805, 11431.885681143081, 11437.0, 11216.158788091088, 11333.0, 11371.31772093677, 11460.770784584094, 11529.1929564933, 9543.0456954304, 9737.221022318055, 9750.073742994404, 9769.2673049523, 9808.901910981085, 7400.629968501661, 7445.255474452511, 7475.215102414386, 7534.811629709082, 7574.3183113520045, 7536.0956685198125, 7593.468457207942, 7669.079710434784, 7674.347680447225, 7693.884591731016], "value": 6816.004760638992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.48934661219266, 515.7318194538839, 517.5471462470339, 520.095034639727, 520.310588470277, 6153.5077193824445, 6171.9382806171925, 6177.691115444221, 6182.9381706182985, 6187.845303867405, 6019.719253007111, 6058.1518587397795, 6079.848003799907, 6105.664188469633, 6121.0, 5055.51972562606, 5081.720505372203, 5108.131617624994, 5109.576583688938, 5118.232265160219, 4714.151452738506, 4918.458969513351, 5000.19996800512, 5072.923906141411, 5120.564751996066, 4819.566119109844, 4825.855224343275, 4846.369971903648, 4873.756312184377, 4874.439439464471, 4766.285057241407, 4790.736509491977, 4791.377120974251, 4828.73441960692, 4883.1942729449775, 4323.805428755713, 4327.204210252741, 4372.256716358195, 4404.4494438195225, 4426.468823741139, 5904.143899134644, 5930.229070220844, 5956.940430595725, 5988.7604495820115, 5994.430529099772, 5569.275994120739, 5575.330960284751, 5607.859803504904, 5638.323401191842, 5647.152927060933, 6509.121268628769, 6511.902321465182, 6523.967380163116, 6535.934640653581, 6543.901841472334, 4806.855794326176, 4818.650777782192, 4823.421189457253, 4830.178869592142, 4831.4926932671915, 6596.241432235306, 6728.932710672929, 6731.206549282091, 6745.998030876262, 6780.8304792380095, 4842.951570484321, 4925.596205081534, 4929.0, 4932.950670493249, 4941.703497790144, 4995.200767877195, 4996.525330093636, 5009.373828271466, 5015.724135172601, 5025.321581586439, 5569.610127291132, 5601.579881508903, 5606.887862242814, 5608.915866262009, 5610.018246806792, 6524.543281970311, 6539.836504087436, 6543.0, 6548.0, 6567.0, 1736.270766278166, 1743.476956912921, 1745.3106023120797, 1747.9475615731549, 1747.9563010924828, 1139.3391832736993, 1207.2575366149931, 1212.1030437476204, 1212.921160124589, 1218.3299185447968, 5645.943540564624, 5656.462636049569, 5672.773089076473, 5691.317041954909, 5707.258056452634, 6537.5750576212395, 6610.173728283965, 6610.570312929644, 6617.86764264712, 6628.83427914306, 5492.313460817398, 5587.497125258747, 5610.102383618601, 5613.803516876889, 5639.548836093103, 3446.6208717041104, 3474.1488335358, 3484.982575087108, 3485.320362529333, 3502.9299414011575, 6341.936580634135, 6345.206849143857, 6361.141245931833, 6373.139626150503, 6431.360003199155, 6707.0610114584, 6712.194536655633, 6796.898046529306, 6819.215790184093, 6829.214640316328, 6415.935840641627, 6422.197225346832, 6432.06735023419, 6434.131392261985, 6463.612183268925, 5953.166556681981, 6424.164858568356, 6616.569922954993, 6627.37039981201, 6639.571125794789, 6483.546151769519, 6550.213974323112, 6568.277489476058, 6593.901091483727, 6607.372299631527, 6231.189945307081, 6305.274893387319, 6334.714937827716, 6413.4869210463985, 6438.098666186831, 4866.099771542276, 4895.363602731622, 4902.044101400193, 4916.262560615936, 4940.92588611164, 6397.744090236339, 6538.738450462119, 6544.3311955452955, 6662.866742665023, 6681.164854393201, 6197.504199663926, 6336.714847831767, 6360.268569114426, 6371.93628063732, 6376.840578985377, 6322.873542529215, 6354.633753742967, 6371.776987805404, 6425.935740642721, 6442.162518872704, 6284.622922624657, 6301.149344838572, 6339.714712837841, 6349.7142628580905, 6385.329540398191, 6403.96798016007, 6404.231492220963, 6426.550141490051, 6443.226812782309, 6469.353064693493, 6209.254889413119, 6253.749850006131, 6284.937150628618, 6292.559520833681, 6357.1735674362035], "value": 4971.429556381426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.4082712514801, 886.1979908183097, 887.9911200887989, 898.2679116520036, 927.0914503786289, 18340.266389344426, 18934.337298194583, 18941.14764835582, 18955.52611184721, 18983.0, 18298.817011829877, 18424.723629145574, 18463.169157387918, 18612.0, 18633.440996770118, 933.5099072986668, 944.1219665710886, 944.36255527519, 948.0235357581702, 949.9952500237489, 960.0303693269778, 964.5129209749067, 965.3869792681662, 966.3911735606558, 968.5544649461257, 979.6718099436697, 1012.2559918459926, 1017.7506510904839, 1017.9440130792804, 1019.0319196763068, 1004.3321191407705, 1008.1430783833756, 1008.7931973945324, 1008.9495525223746, 1012.8480727890839, 752.1763668782675, 752.2515097478044, 752.3454594502817, 752.5522314223083, 753.2618034326337, 17642.91178544112, 17878.463646090637, 18033.639327213514, 19668.40994770145, 20102.597948041104, 21359.359219223294, 21423.57152856934, 21858.781412185832, 21871.453213669625, 21918.671219931715, 17082.487525374258, 17479.38822141219, 17563.824361756346, 17583.560410989827, 17680.115994200238, 3581.6418358163974, 3613.5663720353464, 3617.656322649344, 3623.981880090609, 3624.075860655516, 107772.0, 115447.0, 145239.0, 149839.0, 151532.0, 16688.415905443253, 17223.56941076483, 17325.0, 17355.13224338778, 17406.738898916527, 30696.232594185323, 31305.0, 31505.8424707875, 31521.0, 31614.367712645617, 8817.0, 8855.690050848189, 8873.911260887438, 8891.510966896753, 8899.777505562413, 4149.792510374469, 4201.369794530845, 4307.978460107742, 4309.202797482476, 4312.116016216668, 5413.0, 5438.782448702087, 5458.4814442627885, 5470.890582188334, 5501.477359650827, 1075.4300220882944, 1118.1166878166157, 1125.983110253347, 1126.7126882644873, 1128.9266197697123, 660.8513084555937, 665.8002599220215, 678.2844099475101, 683.8358793889431, 689.7654797368818, 11604.0, 11709.355985420883, 12104.0, 12794.232346059267, 12807.231566106064, 678.9422899053537, 682.7200847652538, 687.7077242172057, 690.0752990992095, 705.1291654806311, 5630.268065151504, 5667.037811874323, 5735.512481439041, 5783.277090363705, 5840.123981402823, 116438.41780791042, 118217.40891295488, 118828.0, 120272.39863800626, 122273.0, 106050.0, 106752.46623766831, 107158.46420767847, 107419.0, 109689.45155274172, 93701.5314923421, 94526.0, 96636.0, 97824.51087744515, 98440.50779746055, 10722.19583531254, 10793.784124317626, 10821.242513024014, 10924.2899211551, 11033.944830275797, 43193.35209971916, 43445.348319774595, 43819.34270985874, 44615.77692111519, 45185.32222016738, 56843.431565683815, 57974.420255796904, 58168.4183158163, 59168.40831591629, 59929.0, 16021.679566408373, 16360.590985224988, 16418.507444776675, 16626.66746665084, 16649.167541623112, 16413.67172656564, 16510.0, 16631.83368166303, 16640.251188696297, 16764.832351676327, 14624.634384140481, 14769.630759231106, 14791.778123328373, 14875.181864997528, 14980.250987450367, 15855.286512106752, 15900.602484937968, 15950.68098638044, 16010.519684409486, 16156.838431616003, 15359.692806144038, 15375.76936345978, 15378.538643840702, 15489.380424782883, 15618.609534761721, 10712.35725856451, 10881.782364352826, 10924.50839712199, 10944.124470042536, 11265.831012534654, 11338.185890257519, 11351.0, 11411.201215914807, 11500.482478288664, 11517.424128793695], "value": 8861.399346729126, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 108.0, 107.0, 110.0, 109.0, 108.0, 108.0, 107.0, 108.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 140.0, 118.0, 140.0, 167.0, 116.0, 119.0, 116.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 164.0, 169.0, 170.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 74.0, 73.0, 75.0, 78.0, 76.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 81.0, 79.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 117.0, 117.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 150.0, 150.0, 148.0, 149.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 37.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 78.0, 77.0, 79.0, 77.0, 76.0, 74.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 111.0, 118.0, 119.0, 114.0, 116.0, 116.0, 116.0, 115.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 173.0, 182.0, 167.0, 172.0, 167.0, 165.0, 171.0, 166.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 64.0, 64.0, 64.0, 70.0, 67.0, 73.0, 76.0, 67.0], "value": 68.1, "unit": "score"}]}]} 13:47:47 INFO - Return code: 0 13:47:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:47 INFO - # TBPL SUCCESS # 13:47:47 INFO - Running post-action listener: _package_coverage_data 13:47:47 INFO - Running post-action listener: _resource_record_post_action 13:47:47 INFO - [mozharness: 2017-09-15 20:47:47.617908Z] Finished run-tests step (success) 13:47:47 INFO - Running post-run listener: _resource_record_post_run 13:47:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 159744; Write bytes: 338612224; Read time: 428; Write time: 156584 13:47:47 INFO - TinderboxPrint: CPU usage
13.1% 13:47:47 INFO - TinderboxPrint: I/O read bytes / time
159,744 / 428 13:47:47 INFO - TinderboxPrint: I/O write bytes / time
338,612,224 / 156,584 13:47:47 INFO - TinderboxPrint: CPU idle
8,235.6 (86.9%) 13:47:47 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 13:47:47 INFO - TinderboxPrint: Swap in / out
0 / 0 13:47:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13180928; Read time: 0; Write time: 1632 13:47:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:47:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 155648; Write bytes: 325431296; Read time: 424; Write time: 154952 13:47:48 INFO - Running post-run listener: _upload_blobber_files 13:47:48 INFO - Blob upload gear active. 13:47:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:48 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 13:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:47:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:53 INFO - (blobuploader) - INFO - Done attempting. 13:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:53 INFO - (blobuploader) - INFO - Done attempting. 13:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:54 INFO - (blobuploader) - INFO - Done attempting. 13:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:56 INFO - (blobuploader) - INFO - Done attempting. 13:47:56 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:56 INFO - Return code: 0 13:47:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a52bba32ef29a1550204ecb86f6d5d845c966d3a0fb043b2983ce0c07226cd17ff5d726df352357a4492ff197682ae393fe1844aace6e14a176d84784806027e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a0b3d561a91e2c69a90244edf5b704e1d25efc4a1778a14985bdd439218b048023b16740adaed79b81c6354871df7973028c6ea618c760418259e832efb8cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f3b21f11d60961b18992661aa7115afa72ba295ae724aba983299186722e0a95ba7a8a29e2234acefad059de952923388edd1589c4572a05a746748eced61b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64431ccc51dd124e3e778d9d0e87103a97c21e23e2c911ca30a5890b88e257cb12cb5b3e739f1a2ebaf8a65c79e2872e6db2354a5af5107de515a1958825a220"} 13:47:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:56 INFO - Contents: 13:47:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a52bba32ef29a1550204ecb86f6d5d845c966d3a0fb043b2983ce0c07226cd17ff5d726df352357a4492ff197682ae393fe1844aace6e14a176d84784806027e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a0b3d561a91e2c69a90244edf5b704e1d25efc4a1778a14985bdd439218b048023b16740adaed79b81c6354871df7973028c6ea618c760418259e832efb8cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f3b21f11d60961b18992661aa7115afa72ba295ae724aba983299186722e0a95ba7a8a29e2234acefad059de952923388edd1589c4572a05a746748eced61b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64431ccc51dd124e3e778d9d0e87103a97c21e23e2c911ca30a5890b88e257cb12cb5b3e739f1a2ebaf8a65c79e2872e6db2354a5af5107de515a1958825a220"} 13:47:56 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:56 INFO - Copying logs to upload dir... 13:47:56 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.094667 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-15 13:47:55.877463) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:47:55.882408) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a52bba32ef29a1550204ecb86f6d5d845c966d3a0fb043b2983ce0c07226cd17ff5d726df352357a4492ff197682ae393fe1844aace6e14a176d84784806027e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a0b3d561a91e2c69a90244edf5b704e1d25efc4a1778a14985bdd439218b048023b16740adaed79b81c6354871df7973028c6ea618c760418259e832efb8cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f3b21f11d60961b18992661aa7115afa72ba295ae724aba983299186722e0a95ba7a8a29e2234acefad059de952923388edd1589c4572a05a746748eced61b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64431ccc51dd124e3e778d9d0e87103a97c21e23e2c911ca30a5890b88e257cb12cb5b3e739f1a2ebaf8a65c79e2872e6db2354a5af5107de515a1958825a220"} build_url:https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/HEC1C_ZMRHqFUdBa7PZcFg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a52bba32ef29a1550204ecb86f6d5d845c966d3a0fb043b2983ce0c07226cd17ff5d726df352357a4492ff197682ae393fe1844aace6e14a176d84784806027e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48a0b3d561a91e2c69a90244edf5b704e1d25efc4a1778a14985bdd439218b048023b16740adaed79b81c6354871df7973028c6ea618c760418259e832efb8cc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8f3b21f11d60961b18992661aa7115afa72ba295ae724aba983299186722e0a95ba7a8a29e2234acefad059de952923388edd1589c4572a05a746748eced61b", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64431ccc51dd124e3e778d9d0e87103a97c21e23e2c911ca30a5890b88e257cb12cb5b3e739f1a2ebaf8a65c79e2872e6db2354a5af5107de515a1958825a220"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:47:55.917481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:47:55.917815) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1505507236.908254-289951751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:47:55.999805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:47:56.000108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:47:56.000434) ========= ========= Total master_lag: 0.20 =========