builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1504257504.49 results: success (0) revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.494783) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.502293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.502591) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.521732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.522049) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 02:18:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.0M=0s 2017-09-01 02:18:24 (94.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121563 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.673405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.673711) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014337 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.729398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:24.729724) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 583e73fb8e3c734dbf3a5e13913df7617f5c492c --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 583e73fb8e3c734dbf3a5e13913df7617f5c492c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 02:18:24,788 truncating revision to first 12 chars 2017-09-01 02:18:24,788 Setting DEBUG logging. 2017-09-01 02:18:24,788 attempt 1/10 2017-09-01 02:18:24,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/583e73fb8e3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 02:18:25,087 unpacking tar archive at: mozilla-central-583e73fb8e3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:25.363017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:25.363337) ========= script_repo_revision: 583e73fb8e3c734dbf3a5e13913df7617f5c492c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:25.363732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:25.364028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 02:18:25.375778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-09-01 02:18:25.376104) ========= /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=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:25 INFO - MultiFileLogger online at 20170901 02:18:25 in /builds/slave/test 02:18:25 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 02:18:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:25 INFO - {'append_to_log': False, 02:18:25 INFO - 'base_work_dir': '/builds/slave/test', 02:18:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:18:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:25 INFO - 'branch': 'Firefox-Non-PGO', 02:18:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:25 INFO - 'code_coverage': False, 02:18:25 INFO - 'config_files': ('talos/linux_config.py',), 02:18:25 INFO - 'default_actions': ('clobber', 02:18:25 INFO - 'read-buildbot-config', 02:18:25 INFO - 'download-and-extract', 02:18:25 INFO - 'populate-webroot', 02:18:25 INFO - 'create-virtualenv', 02:18:25 INFO - 'install', 02:18:25 INFO - 'setup-mitmproxy', 02:18:25 INFO - 'run-tests'), 02:18:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:25 INFO - 'disable_ccov_upload': False, 02:18:25 INFO - 'disable_stylo': False, 02:18:25 INFO - 'download_minidump_stackwalk': True, 02:18:25 INFO - 'download_symbols': 'ondemand', 02:18:25 INFO - 'enable_stylo': False, 02:18:25 INFO - 'enable_webrender': False, 02:18:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:18:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:25 INFO - 'gecko_profile': False, 02:18:25 INFO - 'gecko_profile_interval': 0, 02:18:25 INFO - 'installer_path': 'installer.exe', 02:18:25 INFO - 'log_level': 'info', 02:18:25 INFO - 'log_name': 'talos', 02:18:25 INFO - 'log_to_console': True, 02:18:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:25 INFO - 'opt_config_files': (), 02:18:25 INFO - 'pip_index': False, 02:18:25 INFO - 'suite': 'dromaeojs-e10s', 02:18:25 INFO - 'system_bits': '32', 02:18:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:25 INFO - 'title': 'talos-linux64-ix-075', 02:18:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:25 INFO - 'use_talos_json': True, 02:18:25 INFO - 'verify': 'False', 02:18:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:25 INFO - 'work_dir': 'build'} 02:18:25 INFO - [mozharness: 2017-09-01 09:18:25.571852Z] Running clobber step. 02:18:25 INFO - Running pre-action listener: _resource_record_pre_action 02:18:25 INFO - Running main action method: clobber 02:18:25 INFO - rmtree: /builds/slave/test/build 02:18:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:26 INFO - Running post-action listener: _resource_record_post_action 02:18:26 INFO - [mozharness: 2017-09-01 09:18:26.579264Z] Finished clobber step (success) 02:18:26 INFO - [mozharness: 2017-09-01 09:18:26.579363Z] Running read-buildbot-config step. 02:18:26 INFO - Running pre-action listener: _resource_record_pre_action 02:18:26 INFO - Running main action method: read_buildbot_config 02:18:26 INFO - Using buildbot properties: 02:18:26 INFO - { 02:18:26 INFO - "project": "", 02:18:26 INFO - "product": "firefox", 02:18:26 INFO - "who": "archaeopteryx@coole-files.de", 02:18:26 INFO - "installer_path": "public/build/target.tar.bz2", 02:18:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:18:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:18:26 INFO - "stage_platform": "linux64", 02:18:26 INFO - "basedir": "/builds/slave/test", 02:18:26 INFO - "buildnumber": 803, 02:18:26 INFO - "platform": "ubuntu64_hw", 02:18:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:18:26 INFO - "slavebuilddir": "test", 02:18:26 INFO - "taskId": "N-27_3A0SK2s_ErIb5zInQ", 02:18:26 INFO - "branch": "mozilla-central", 02:18:26 INFO - "script_repo_revision": "production", 02:18:26 INFO - "revision": "583e73fb8e3c734dbf3a5e13913df7617f5c492c", 02:18:26 INFO - "slavename": "talos-linux64-ix-075", 02:18:26 INFO - "repo_path": "mozilla-central" 02:18:26 INFO - } 02:18:26 INFO - Finding installer, test and symbols from parent task. 02:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-27_3A0SK2s_ErIb5zInQ'}, attempt #1 02:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-27_3A0SK2s_ErIb5zInQ'}, attempt #1 02:18:27 INFO - Task dependencies: EVBwkXv4QIqaI8RoA8-sCA 02:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA'}, attempt #1 02:18:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip 02:18:27 INFO - Running post-action listener: _resource_record_post_action 02:18:27 INFO - [mozharness: 2017-09-01 09:18:27.942713Z] Finished read-buildbot-config step (success) 02:18:27 INFO - [mozharness: 2017-09-01 09:18:27.942931Z] Running download-and-extract step. 02:18:27 INFO - Running pre-action listener: _resource_record_pre_action 02:18:27 INFO - Running main action method: download_and_extract 02:18:27 INFO - mkdir: /builds/slave/test/build/tests 02:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:18:27 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json 02:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:18:28 INFO - Downloaded 989 bytes. 02:18:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:18:28 INFO - Using the following test package requirements: 02:18:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:18:28 INFO - u'common': [u'target.common.tests.zip'], 02:18:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:18:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:18:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:18:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:18:28 INFO - u'mozbase': [u'target.common.tests.zip'], 02:18:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:18:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:18:28 INFO - u'web-platform': [u'target.common.tests.zip', 02:18:28 INFO - u'target.web-platform.tests.tar.gz'], 02:18:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:18:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip 02:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip into memory 02:18:31 INFO - Content-Length response header: 54933742 02:18:31 INFO - Bytes received: 54933742 02:18:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip 02:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.common.tests.zip into memory 02:18:44 INFO - Content-Length response header: 54933742 02:18:44 INFO - Bytes received: 54933742 02:18:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip 02:18:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:18:56 INFO - Fetch https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.talos.tests.zip into memory 02:18:57 INFO - Content-Length response header: 14496650 02:18:57 INFO - Bytes received: 14496650 02:18: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')]} 02:18:57 INFO - trying https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:18:57 INFO - Downloading https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:19:02 INFO - Downloaded 62501484 bytes. 02:19:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:19:02 INFO - mkdir: /builds/slave/test/properties 02:19:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:02 INFO - Contents: 02:19:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 02:19:02 INFO - Running post-action listener: _resource_record_post_action 02:19:02 INFO - Running post-action listener: find_tests_for_verification 02:19:02 INFO - Running post-action listener: set_extra_try_arguments 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.530301Z] Finished download-and-extract step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.530534Z] Running populate-webroot step. 02:19:02 INFO - Running pre-action listener: _resource_record_pre_action 02:19:02 INFO - Running main action method: populate_webroot 02:19:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:02 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:02 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:02 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['damp', 'tps']}, 02:19:02 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['damp', 'tps']}, 02:19:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:19:02 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:19:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:19:02 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:19:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:02 INFO - 'ts_paint', 02:19:02 INFO - 'tpaint', 02:19:02 INFO - 'sessionrestore', 02:19:02 INFO - 'sessionrestore_many_windows', 02:19:02 INFO - 'sessionrestore_no_auto_restore', 02:19:02 INFO - 'tabpaint']}, 02:19:02 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['a11yr', 02:19:02 INFO - 'ts_paint', 02:19:02 INFO - 'tpaint', 02:19:02 INFO - 'sessionrestore', 02:19:02 INFO - 'sessionrestore_many_windows', 02:19:02 INFO - 'sessionrestore_no_auto_restore', 02:19:02 INFO - 'tabpaint']}, 02:19:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:19:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:19:02 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['bloom_basic_singleton']}, 02:19:02 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['bloom_basic']}, 02:19:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:02 INFO - 'tsvgr_opacity', 02:19:02 INFO - 'tart', 02:19:02 INFO - 'tscrollx', 02:19:02 INFO - 'tsvg_static']}, 02:19:02 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tsvgx', 02:19:02 INFO - 'tsvgr_opacity', 02:19:02 INFO - 'tart', 02:19:02 INFO - 'tscrollx', 02:19:02 INFO - 'tsvg_static']}, 02:19:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:02 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo'], 02:19:02 INFO - 'tests': ['tp5o']}, 02:19:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--stylo-threads=1', 02:19:02 INFO - '--mitmproxy', 02:19:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:02 INFO - '--firstNonBlankPaint'], 02:19:02 INFO - 'tests': ['tp6_google', 02:19:02 INFO - 'tp6_youtube', 02:19:02 INFO - 'tp6_amazon', 02:19:02 INFO - 'tp6_facebook']}, 02:19:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--xperf_path', 02:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:02 INFO - 'tests': ['tp5n']}, 02:19:02 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:19:02 INFO - 'talos_options': ['--enable-stylo', 02:19:02 INFO - '--xperf_path', 02:19:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:02 INFO - 'tests': ['tp5n']}}} 02:19:02 INFO - Running post-action listener: _resource_record_post_action 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.551765Z] Finished populate-webroot step (success) 02:19:02 INFO - [mozharness: 2017-09-01 09:19:02.551856Z] Running create-virtualenv step. 02:19:02 INFO - Running pre-action listener: _resource_record_pre_action 02:19:02 INFO - Running main action method: create_virtualenv 02:19:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:02 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:19:02 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:19:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:19:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:03 INFO - Installing pip...............done. 02:19:03 INFO - Return code: 0 02:19:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:19:03 INFO - Reading from file tmpfile_stdout 02:19:03 INFO - Output received: 02:19:03 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:03 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 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:03 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 02:19:03 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 02:19:03 INFO - Using env: {'DISPLAY': ':0', 02:19:03 INFO - 'HOME': '/home/cltbld', 02:19:03 INFO - 'LANG': 'en_US.UTF-8', 02:19:03 INFO - 'LANGUAGE': 'en_US:en', 02:19:03 INFO - 'LOGNAME': 'cltbld', 02:19:03 INFO - 'MAIL': '/var/mail/cltbld', 02:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:03 INFO - 'MOZ_NO_REMOTE': '1', 02:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:03 INFO - 'NO_EM_RESTART': '1', 02:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:03 INFO - 'PWD': '/builds/slave/test', 02:19:03 INFO - 'SHELL': '/bin/bash', 02:19:03 INFO - 'SHLVL': '1', 02:19:03 INFO - 'TERM': 'linux', 02:19:03 INFO - 'TMOUT': '86400', 02:19:03 INFO - 'USER': 'cltbld', 02:19:03 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:03 INFO - '_': '/tools/buildbot/bin/python'} 02:19:07 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:19:07 INFO - Downloading/unpacking pip>=1.5 02:19:07 INFO - Running setup.py egg_info for package pip 02:19:07 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:07 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:07 INFO - Installing collected packages: pip 02:19:07 INFO - Found existing installation: pip 1.1 02:19:07 INFO - Uninstalling pip: 02:19:07 INFO - Successfully uninstalled pip 02:19:07 INFO - Running setup.py install for pip 02:19:07 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:07 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:07 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:07 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:07 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:19:07 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:19:07 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:19:07 INFO - Successfully installed pip 02:19:07 INFO - Cleaning up... 02:19:07 INFO - Return code: 0 02:19:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:19:07 INFO - Using env: {'DISPLAY': ':0', 02:19:07 INFO - 'HOME': '/home/cltbld', 02:19:07 INFO - 'LANG': 'en_US.UTF-8', 02:19:07 INFO - 'LANGUAGE': 'en_US:en', 02:19:07 INFO - 'LOGNAME': 'cltbld', 02:19:07 INFO - 'MAIL': '/var/mail/cltbld', 02:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:07 INFO - 'MOZ_NO_REMOTE': '1', 02:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:07 INFO - 'NO_EM_RESTART': '1', 02:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:07 INFO - 'PWD': '/builds/slave/test', 02:19:07 INFO - 'SHELL': '/bin/bash', 02:19:07 INFO - 'SHLVL': '1', 02:19:07 INFO - 'TERM': 'linux', 02:19:07 INFO - 'TMOUT': '86400', 02:19:07 INFO - 'USER': 'cltbld', 02:19:07 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:07 INFO - '_': '/tools/buildbot/bin/python'} 02:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:07 INFO - Downloading/unpacking psutil>=3.1.1 02:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:09 INFO - Installing collected packages: psutil 02:19:09 INFO - Running setup.py install for psutil 02:19:09 INFO - building 'psutil._psutil_linux' extension 02:19:09 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 02:19:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:19:09 INFO - building 'psutil._psutil_posix' extension 02:19:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:19:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:09 INFO - Successfully installed psutil 02:19:09 INFO - Cleaning up... 02:19:09 INFO - Return code: 0 02:19:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:19:09 INFO - Using env: {'DISPLAY': ':0', 02:19:09 INFO - 'HOME': '/home/cltbld', 02:19:09 INFO - 'LANG': 'en_US.UTF-8', 02:19:09 INFO - 'LANGUAGE': 'en_US:en', 02:19:09 INFO - 'LOGNAME': 'cltbld', 02:19:09 INFO - 'MAIL': '/var/mail/cltbld', 02:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:09 INFO - 'MOZ_NO_REMOTE': '1', 02:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:09 INFO - 'NO_EM_RESTART': '1', 02:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:09 INFO - 'PWD': '/builds/slave/test', 02:19:09 INFO - 'SHELL': '/bin/bash', 02:19:09 INFO - 'SHLVL': '1', 02:19:09 INFO - 'TERM': 'linux', 02:19:09 INFO - 'TMOUT': '86400', 02:19:09 INFO - 'USER': 'cltbld', 02:19:09 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:09 INFO - '_': '/tools/buildbot/bin/python'} 02:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:11 INFO - Installing collected packages: mozsystemmonitor 02:19:11 INFO - Running setup.py install for mozsystemmonitor 02:19:11 INFO - Successfully installed mozsystemmonitor 02:19:11 INFO - Cleaning up... 02:19:11 INFO - Return code: 0 02:19:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:11 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')]} 02:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:11 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')]} 02:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:11 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 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:11 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 02:19:11 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 02:19:11 INFO - Using env: {'DISPLAY': ':0', 02:19:11 INFO - 'HOME': '/home/cltbld', 02:19:11 INFO - 'LANG': 'en_US.UTF-8', 02:19:11 INFO - 'LANGUAGE': 'en_US:en', 02:19:11 INFO - 'LOGNAME': 'cltbld', 02:19:11 INFO - 'MAIL': '/var/mail/cltbld', 02:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:11 INFO - 'MOZ_NO_REMOTE': '1', 02:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:11 INFO - 'NO_EM_RESTART': '1', 02:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:11 INFO - 'PWD': '/builds/slave/test', 02:19:11 INFO - 'SHELL': '/bin/bash', 02:19:11 INFO - 'SHLVL': '1', 02:19:11 INFO - 'TERM': 'linux', 02:19:11 INFO - 'TMOUT': '86400', 02:19:11 INFO - 'USER': 'cltbld', 02:19:11 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:11 INFO - '_': '/tools/buildbot/bin/python'} 02:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:11 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:12 INFO - warning: no files found matching '*.txt' 02:19:12 INFO - no previously-included directories found matching 'build' 02:19:12 INFO - no previously-included directories found matching 'dist' 02:19:12 INFO - no previously-included directories found matching '.git*' 02:19:12 INFO - Installing collected packages: jsonschema, functools32 02:19:12 INFO - Running setup.py install for functools32 02:19:12 INFO - warning: no files found matching '*.txt' 02:19:12 INFO - no previously-included directories found matching 'build' 02:19:12 INFO - no previously-included directories found matching 'dist' 02:19:12 INFO - no previously-included directories found matching '.git*' 02:19:12 INFO - Successfully installed jsonschema functools32 02:19:12 INFO - Cleaning up... 02:19:12 INFO - Return code: 0 02:19:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:19:12 INFO - Using env: {'DISPLAY': ':0', 02:19:12 INFO - 'HOME': '/home/cltbld', 02:19:12 INFO - 'LANG': 'en_US.UTF-8', 02:19:12 INFO - 'LANGUAGE': 'en_US:en', 02:19:12 INFO - 'LOGNAME': 'cltbld', 02:19:12 INFO - 'MAIL': '/var/mail/cltbld', 02:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:12 INFO - 'MOZ_NO_REMOTE': '1', 02:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:12 INFO - 'NO_EM_RESTART': '1', 02:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:12 INFO - 'PWD': '/builds/slave/test', 02:19:12 INFO - 'SHELL': '/bin/bash', 02:19:12 INFO - 'SHLVL': '1', 02:19:12 INFO - 'TERM': 'linux', 02:19:12 INFO - 'TMOUT': '86400', 02:19:12 INFO - 'USER': 'cltbld', 02:19:12 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:12 INFO - '_': '/tools/buildbot/bin/python'} 02:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:19:13 INFO - Cleaning up... 02:19:13 INFO - Return code: 0 02:19:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:13 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 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:13 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 02:19:13 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 02:19:13 INFO - Using env: {'DISPLAY': ':0', 02:19:13 INFO - 'HOME': '/home/cltbld', 02:19:13 INFO - 'LANG': 'en_US.UTF-8', 02:19:13 INFO - 'LANGUAGE': 'en_US:en', 02:19:13 INFO - 'LOGNAME': 'cltbld', 02:19:13 INFO - 'MAIL': '/var/mail/cltbld', 02:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:13 INFO - 'MOZ_NO_REMOTE': '1', 02:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:13 INFO - 'NO_EM_RESTART': '1', 02:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:13 INFO - 'PWD': '/builds/slave/test', 02:19:13 INFO - 'SHELL': '/bin/bash', 02:19:13 INFO - 'SHLVL': '1', 02:19:13 INFO - 'TERM': 'linux', 02:19:13 INFO - 'TMOUT': '86400', 02:19:13 INFO - 'USER': 'cltbld', 02:19:13 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:13 INFO - '_': '/tools/buildbot/bin/python'} 02:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:13 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:14 INFO - Downloading docopt-0.6.1.tar.gz 02:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:15 INFO - Running setup.py install for blobuploader 02:19:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:15 INFO - Running setup.py install for requests 02:19:15 INFO - Running setup.py install for docopt 02:19:15 INFO - Successfully installed blobuploader requests docopt 02:19:15 INFO - Cleaning up... 02:19:15 INFO - Return code: 0 02:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:19:15 INFO - Using env: {'DISPLAY': ':0', 02:19:15 INFO - 'HOME': '/home/cltbld', 02:19:15 INFO - 'LANG': 'en_US.UTF-8', 02:19:15 INFO - 'LANGUAGE': 'en_US:en', 02:19:15 INFO - 'LOGNAME': 'cltbld', 02:19:15 INFO - 'MAIL': '/var/mail/cltbld', 02:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:15 INFO - 'MOZ_NO_REMOTE': '1', 02:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:15 INFO - 'NO_EM_RESTART': '1', 02:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:15 INFO - 'PWD': '/builds/slave/test', 02:19:15 INFO - 'SHELL': '/bin/bash', 02:19:15 INFO - 'SHLVL': '1', 02:19:15 INFO - 'TERM': 'linux', 02:19:15 INFO - 'TMOUT': '86400', 02:19:15 INFO - 'USER': 'cltbld', 02:19:15 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:15 INFO - '_': '/tools/buildbot/bin/python'} 02:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:15 INFO - Running setup.py (path:/tmp/pip-2MOCox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 INFO - Running setup.py (path:/tmp/pip-nSTwFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 INFO - Running setup.py (path:/tmp/pip-rbf65g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:16 INFO - Running setup.py (path:/tmp/pip-jmXBGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:16 INFO - Running setup.py (path:/tmp/pip-tEMTpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:16 INFO - Running setup.py (path:/tmp/pip-Rrr7B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:16 INFO - Running setup.py (path:/tmp/pip-3wnbpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:16 INFO - Running setup.py (path:/tmp/pip-oT0ZUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:16 INFO - Running setup.py (path:/tmp/pip-giBhRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:16 INFO - Running setup.py (path:/tmp/pip-wgwq3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:16 INFO - Running setup.py (path:/tmp/pip-J0BTFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:16 INFO - Running setup.py (path:/tmp/pip-Iw7R0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:16 INFO - Running setup.py (path:/tmp/pip-a1EAeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:16 INFO - Running setup.py (path:/tmp/pip-yeeq8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:16 INFO - Running setup.py (path:/tmp/pip-W9aUHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:16 INFO - Running setup.py (path:/tmp/pip-ndCoET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:16 INFO - Running setup.py (path:/tmp/pip-8M7mCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:17 INFO - Running setup.py install for manifestparser 02:19:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozcrash 02:19:17 INFO - Running setup.py install for mozdebug 02:19:17 INFO - Running setup.py install for mozdevice 02:19:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozfile 02:19:17 INFO - Running setup.py install for mozhttpd 02:19:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozinfo 02:19:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozInstall 02:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozleak 02:19:17 INFO - Running setup.py install for mozlog 02:19:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Running setup.py install for moznetwork 02:19:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Running setup.py install for mozprocess 02:19:18 INFO - Running setup.py install for mozprofile 02:19:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Running setup.py install for mozrunner 02:19:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Running setup.py install for mozscreenshot 02:19:18 INFO - Running setup.py install for moztest 02:19:18 INFO - Running setup.py install for mozversion 02:19:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:18 INFO - Cleaning up... 02:19:18 INFO - Return code: 0 02:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:19:18 INFO - Using env: {'DISPLAY': ':0', 02:19:18 INFO - 'HOME': '/home/cltbld', 02:19:18 INFO - 'LANG': 'en_US.UTF-8', 02:19:18 INFO - 'LANGUAGE': 'en_US:en', 02:19:18 INFO - 'LOGNAME': 'cltbld', 02:19:18 INFO - 'MAIL': '/var/mail/cltbld', 02:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:18 INFO - 'MOZ_NO_REMOTE': '1', 02:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:18 INFO - 'NO_EM_RESTART': '1', 02:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:18 INFO - 'PWD': '/builds/slave/test', 02:19:18 INFO - 'SHELL': '/bin/bash', 02:19:18 INFO - 'SHLVL': '1', 02:19:18 INFO - 'TERM': 'linux', 02:19:18 INFO - 'TMOUT': '86400', 02:19:18 INFO - 'USER': 'cltbld', 02:19:18 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:18 INFO - '_': '/tools/buildbot/bin/python'} 02:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:19 INFO - Running setup.py (path:/tmp/pip-9OZvgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:19 INFO - Running setup.py (path:/tmp/pip-wO6ekg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:19 INFO - Running setup.py (path:/tmp/pip-dBgATr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:19 INFO - Running setup.py (path:/tmp/pip-YXvXmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:19 INFO - Running setup.py (path:/tmp/pip-VlY1Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:19 INFO - Running setup.py (path:/tmp/pip-jfJD_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:19 INFO - Running setup.py (path:/tmp/pip-jRxrRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:19 INFO - Running setup.py (path:/tmp/pip-lQasKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:19 INFO - Running setup.py (path:/tmp/pip-sn6xJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:19 INFO - Running setup.py (path:/tmp/pip-hBqRV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:19 INFO - Running setup.py (path:/tmp/pip-s66EZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:19 INFO - Running setup.py (path:/tmp/pip-yX8v3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:19 INFO - Running setup.py (path:/tmp/pip-Odxou6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:19 INFO - Running setup.py (path:/tmp/pip-DlrifE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:20 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)) 02:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:20 INFO - Running setup.py (path:/tmp/pip-8NpiL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:20 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)) 02:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:20 INFO - Running setup.py (path:/tmp/pip-Jcr5GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:20 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)) 02:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:20 INFO - Running setup.py (path:/tmp/pip-SN8yNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:20 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)) 02:19:20 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)) 02:19:20 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)) 02:19:20 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)) 02:19:20 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)) 02:19:20 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)) 02:19:20 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)) 02:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:20 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 02:19:20 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 02:19:20 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 02:19:20 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 02:19:21 INFO - Downloading blessings-1.6.tar.gz 02:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:21 INFO - Installing collected packages: blessings 02:19:21 INFO - Running setup.py install for blessings 02:19:21 INFO - Successfully installed blessings 02:19:21 INFO - Cleaning up... 02:19:21 INFO - Return code: 0 02:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:21 INFO - Reading from file tmpfile_stdout 02:19:21 INFO - Current package versions: 02:19:21 INFO - argparse == 1.2.1 02:19:21 INFO - blessings == 1.6 02:19:21 INFO - blobuploader == 1.2.4 02:19:21 INFO - docopt == 0.6.1 02:19:21 INFO - functools32 == 3.2.3-2 02:19:21 INFO - jsonschema == 2.5.1 02:19:21 INFO - manifestparser == 1.1 02:19:21 INFO - mozInstall == 1.13 02:19:21 INFO - mozcrash == 1.0 02:19:21 INFO - mozdebug == 0.1 02:19:21 INFO - mozdevice == 0.51 02:19:21 INFO - mozfile == 1.2 02:19:21 INFO - mozhttpd == 0.7 02:19:21 INFO - mozinfo == 0.10 02:19:21 INFO - mozleak == 0.1 02:19:21 INFO - mozlog == 3.5 02:19:21 INFO - moznetwork == 0.27 02:19:21 INFO - mozprocess == 0.25 02:19:21 INFO - mozprofile == 0.28 02:19:21 INFO - mozrunner == 6.13 02:19:21 INFO - mozscreenshot == 0.1 02:19:21 INFO - mozsystemmonitor == 0.3 02:19:21 INFO - moztest == 0.8 02:19:21 INFO - mozversion == 1.4 02:19:21 INFO - psutil == 3.1.1 02:19:21 INFO - requests == 1.2.3 02:19:21 INFO - wsgiref == 0.1.2 02:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:19:21 INFO - Using env: {'DISPLAY': ':0', 02:19:21 INFO - 'HOME': '/home/cltbld', 02:19:21 INFO - 'LANG': 'en_US.UTF-8', 02:19:21 INFO - 'LANGUAGE': 'en_US:en', 02:19:21 INFO - 'LOGNAME': 'cltbld', 02:19:21 INFO - 'MAIL': '/var/mail/cltbld', 02:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:21 INFO - 'MOZ_NO_REMOTE': '1', 02:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:21 INFO - 'NO_EM_RESTART': '1', 02:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:21 INFO - 'PWD': '/builds/slave/test', 02:19:21 INFO - 'SHELL': '/bin/bash', 02:19:21 INFO - 'SHLVL': '1', 02:19:21 INFO - 'TERM': 'linux', 02:19:21 INFO - 'TMOUT': '86400', 02:19:21 INFO - 'USER': 'cltbld', 02:19:21 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:21 INFO - '_': '/tools/buildbot/bin/python'} 02:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:19:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:19:23 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)) 02:19:23 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)) 02:19:23 INFO - Installing collected packages: simplejson 02:19:23 INFO - Running setup.py install for simplejson 02:19:23 INFO - building 'simplejson._speedups' extension 02:19:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:19:24 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 02:19:24 INFO - Successfully installed simplejson 02:19:24 INFO - Cleaning up... 02:19:24 INFO - Return code: 0 02:19:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:24 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')]} 02:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:24 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')]} 02:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:24 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 0x15211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', '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 02:19:24 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 02:19:24 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 02:19:24 INFO - Using env: {'DISPLAY': ':0', 02:19:24 INFO - 'HOME': '/home/cltbld', 02:19:24 INFO - 'LANG': 'en_US.UTF-8', 02:19:24 INFO - 'LANGUAGE': 'en_US:en', 02:19:24 INFO - 'LOGNAME': 'cltbld', 02:19:24 INFO - 'MAIL': '/var/mail/cltbld', 02:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:24 INFO - 'MOZ_NO_REMOTE': '1', 02:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:24 INFO - 'NO_EM_RESTART': '1', 02:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:24 INFO - 'PWD': '/builds/slave/test', 02:19:24 INFO - 'SHELL': '/bin/bash', 02:19:24 INFO - 'SHLVL': '1', 02:19:24 INFO - 'TERM': 'linux', 02:19:24 INFO - 'TMOUT': '86400', 02:19:24 INFO - 'USER': 'cltbld', 02:19:24 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:24 INFO - '_': '/tools/buildbot/bin/python'} 02:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:24 INFO - Cleaning up... 02:19:24 INFO - Return code: 0 02:19:24 INFO - Running post-action listener: _resource_record_post_action 02:19:24 INFO - Running post-action listener: _start_resource_monitoring 02:19:24 INFO - Starting resource monitoring. 02:19:24 INFO - [mozharness: 2017-09-01 09:19:24.467254Z] Finished create-virtualenv step (success) 02:19:24 INFO - [mozharness: 2017-09-01 09:19:24.467768Z] Running install step. 02:19:24 INFO - Running pre-action listener: _resource_record_pre_action 02:19:24 INFO - Running main action method: install 02:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:24 INFO - Reading from file tmpfile_stdout 02:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:24 INFO - Reading from file tmpfile_stdout 02:19:24 INFO - Output received: 02:19:24 INFO - Usage: mozinstall [options] installer 02:19:24 INFO - Options: 02:19:24 INFO - -h, --help show this help message and exit 02:19:24 INFO - -d DEST, --destination=DEST 02:19:24 INFO - Directory to install application into. [default: 02:19:24 INFO - "/builds/slave/test"] 02:19:24 INFO - --app=APP Application being installed. [default: firefox] 02:19:24 INFO - mkdir: /builds/slave/test/build/application 02:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:19:41 INFO - Reading from file tmpfile_stdout 02:19:41 INFO - Output received: 02:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:41 INFO - Running post-action listener: _resource_record_post_action 02:19:41 INFO - [mozharness: 2017-09-01 09:19:41.277255Z] Finished install step (success) 02:19:41 INFO - [mozharness: 2017-09-01 09:19:41.277453Z] Running setup-mitmproxy step. 02:19:41 INFO - Running pre-action listener: _resource_record_pre_action 02:19:41 INFO - Running main action method: setup_mitmproxy 02:19:41 INFO - Skipping: mitmproxy is not required 02:19:41 INFO - Running post-action listener: _resource_record_post_action 02:19:41 INFO - [mozharness: 2017-09-01 09:19:41.278590Z] Finished setup-mitmproxy step (success) 02:19:41 INFO - [mozharness: 2017-09-01 09:19:41.278809Z] Running run-tests step. 02:19:41 INFO - Running pre-action listener: _resource_record_pre_action 02:19:41 INFO - Running pre-action listener: _set_gcov_prefix 02:19:41 INFO - Running main action method: run_tests 02:19:41 WARNING - Try message not found. 02:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:41 INFO - Python 2.7.3 02:19:41 INFO - Return code: 0 02:19:41 INFO - grabbing minidump binary from tooltool 02:19:41 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')]} 02:19:41 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 0x1891090>, '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 0x1891d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:41 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 02:19:41 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 02:19:41 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 02:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:41 INFO - Return code: 0 02:19:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:41 INFO - ENV: RUST_BACKTRACE is now full 02:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:41 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:19:41 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:19:41 INFO - Using env: {'DISPLAY': ':0', 02:19:41 INFO - 'HOME': '/home/cltbld', 02:19:41 INFO - 'LANG': 'en_US.UTF-8', 02:19:41 INFO - 'LANGUAGE': 'en_US:en', 02:19:41 INFO - 'LOGNAME': 'cltbld', 02:19:41 INFO - 'MAIL': '/var/mail/cltbld', 02:19:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:41 INFO - 'MOZ_NO_REMOTE': '1', 02:19:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:41 INFO - 'NO_EM_RESTART': '1', 02:19:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:41 INFO - 'PWD': '/builds/slave/test', 02:19:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:41 INFO - 'RUST_BACKTRACE': 'full', 02:19:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:41 INFO - 'SHELL': '/bin/bash', 02:19:41 INFO - 'SHLVL': '1', 02:19:41 INFO - 'TERM': 'linux', 02:19:41 INFO - 'TMOUT': '86400', 02:19:41 INFO - 'USER': 'cltbld', 02:19:41 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:41 INFO - '_': '/tools/buildbot/bin/python'} 02:19:41 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/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:19:41 INFO - mozversion application_buildid: 20170901083126 02:19:41 INFO - mozversion application_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:41 INFO - mozversion application_display_name: Nightly 02:19:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:41 INFO - mozversion application_name: Firefox 02:19:41 INFO - mozversion application_remotingname: firefox 02:19:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:19:41 INFO - mozversion application_vendor: Mozilla 02:19:41 INFO - mozversion application_version: 57.0a1 02:19:41 INFO - mozversion platform_buildid: 20170901083126 02:19:41 INFO - mozversion platform_changeset: 583e73fb8e3c734dbf3a5e13913df7617f5c492c 02:19:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:19:41 INFO - mozversion platform_version: 57.0a1 02:19:41 INFO - using testdate: 1504257581 02:19:41 INFO - actual date: 1504257581 02:19:41 INFO - starting webserver on 'localhost:57267' 02:19:41 INFO - SUITE-START | Running 2 tests 02:19:41 INFO - TEST-START | dromaeo_css 02:19:41 INFO - Initialising browser for dromaeo_css test... 02:19:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57267/getInfo.html -profile /tmp/tmpCD82cZ/profile 02:19:41 INFO - TEST-INFO | started process 7020 (/builds/slave/test/build/application/firefox/firefox http://localhost:57267/getInfo.html) 02:19:47 INFO - TEST-INFO | 7020: exit 0 02:19:47 INFO - Browser initialized. 02:19:47 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:47 INFO - Using env: {'DISPLAY': ':0', 02:19:47 INFO - 'HOME': '/home/cltbld', 02:19:47 INFO - 'JSGC_DISABLE_POISONING': '1', 02:19:47 INFO - 'LANG': 'en_US.UTF-8', 02:19:47 INFO - 'LANGUAGE': 'en_US:en', 02:19:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:19:47 INFO - 'LOGNAME': 'cltbld', 02:19:47 INFO - 'MAIL': '/var/mail/cltbld', 02:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:47 INFO - 'MOZ_CRASHREPORTER': '1', 02:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:19:47 INFO - 'MOZ_NO_REMOTE': '1', 02:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:47 INFO - 'NO_EM_RESTART': '1', 02:19:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:47 INFO - 'PWD': '/builds/slave/test', 02:19:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:47 INFO - 'RUST_BACKTRACE': 'full', 02:19:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:47 INFO - 'SHELL': '/bin/bash', 02:19:47 INFO - 'SHLVL': '1', 02:19:47 INFO - 'TERM': 'linux', 02:19:47 INFO - 'TMOUT': '86400', 02:19:47 INFO - 'USER': 'cltbld', 02:19:47 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:47 INFO - '_': '/tools/buildbot/bin/python'} 02:19:47 INFO - TEST-INFO | started process 7201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCD82cZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:48 INFO - PID 7201 | 02:19:48 INFO - PID 7201 | (/builds/slave/test/build/application/firefox/firefox:7252): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:19:48 INFO - PID 7201 | 02:19:58 INFO - PID 7201 | RSS: Main: 169926656 02:19:58 INFO - PID 7201 | 02:22:56 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57267/tests/dromaeo/cssquery-ext.html) 02:22:58 INFO - PID 7201 | RSS: Main: 171921408 02:22:58 INFO - PID 7201 | 02:26:00 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-ext.html (next: http://localhost:57267/tests/dromaeo/cssquery-jquery.html) 02:26:01 INFO - PID 7201 | RSS: Main: 168239104 02:26:01 INFO - PID 7201 | 02:29:02 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57267/tests/dromaeo/cssquery-mootools.html) 02:29:03 INFO - PID 7201 | RSS: Main: 170471424 02:29:03 INFO - PID 7201 | 02:32:05 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57267/tests/dromaeo/cssquery-prototype.html) 02:32:05 INFO - PID 7201 | RSS: Main: 167383040 02:32:05 INFO - PID 7201 | 02:35:09 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57267/tests/dromaeo/cssquery-yui.html) 02:35:10 INFO - PID 7201 | RSS: Main: 170409984 02:35:10 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | Cycle 1(1): loaded http://localhost:57267/tests/dromaeo/cssquery-yui.html (next: http://localhost:57267/tests/dromaeo/cssquery-dojo.html) 02:38:11 INFO - PID 7201 | RSS: Main: 173465600 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | __start_tp_report 02:38:11 INFO - PID 7201 | _x_x_mozilla_page_load 02:38:11 INFO - PID 7201 | _x_x_mozilla_page_load_details 02:38:11 INFO - PID 7201 | |i|pagename|runs| 02:38:11 INFO - PID 7201 | |0;dojo.html;3277.5575297334867;3316.303576248991;3341.164708822795;3347.9832600837;3385.086026772771;6244.968775156123;6386.361363863617;6519.674016299178;6527.281998980108;6561.048647946057;6153.384661533844;6239.095331176976;6256.530760192981;6266.905996410058;6292.874142517158;5784.913226301598;5794.043982742843;5885.470307672309;5919.934411805873;5983.940160598382;5962.165296858421;5996.2504686914135;6002.639841609495;6009.57932944694;6049.727762250709;5764.855878603026;5824.330202026778;5846.298444186704;5965.1946987156825;5970.940290597104;5826.941730582682;5898.292204935392;5934.198883150784;5963.493103086243;5967.194428752106;5780.16187652788;5802.796672717507;5823.505002074829;5830.416958304136;5838.503727183194;6390.680465976682;6398.680065996681;6399.584027038228;6403.551751377406;6415.518836087312;6840.6921688524135;6888.173419189679;6953.130858642669;6955.304469553055;6973.267806880306;6592.835179120512;6900.275471075565;6913.619750913697;7000.439964802855;7006.649667516604;6293.811185664437;6302.432781049636;6307.716152773136;6311.526635502356;6311.905321420182;6952.548084374601;7128.215896251409;7136.464765142635;7186.6047367395295;7244.782656520313;6820.04519367289;6885.414739747077;6896.517243792886;6899.103116594811;6901.792946211622;6927.064846245692;6940.826479337956;6968.198657154492;7041.788746337618;7059.399951004222;6529.151210342625;6611.669416529155;6621.834454138685;6633.800985970429;6645.667716614246;6656.83357916056;6674.599524028574;6759.628220447824;6930.06444130036;6939.479539034593;5400.162974738922;5402.837914862561;5402.864928376822;5410.1343784994215;5416.647917885325;4691.13214055394;4731.219348807477;4738.360321356573;4742.430908291027;4747.264174053027;5799.5650326225705;5867.413258674099;5916.7337469813965;5957.821265362046;6013.428724271187;6956.165260168711;6984.476164287698;7020.473464490184;7046.401055910305;7049.365557099885;6028.758849645965;6030.577859549877;6042.939570604326;6102.572819902653;6110.327863934964;5904.409559044061;5919.378465261086;5989.520838332923;5996.640201587918;5998.280206375263;6485.967570162119;6580.440662543738;6629.86740265192;6752.358525940028;6753;6917.584944903322;6934.514583979073;6977.023216749761;6981.2669669683955;7005.019297298484;6575;6665.933340666726;6697.7655782047395;6760.459163266829;6762.932370676231;6568.310327415744;6808.183018037867;6810.353016463428;6900.7929762107215;6910.585364878123;6824.7952561423235;6952.756653517103;7031.437485001085;7033.7186512540975;7034.788956331318;6728.831779205559;6746.359095885883;6816.216135144522;6818.147731533559;6828.590284582742;6411.230652321751;6501.34986501365;6504.414602685781;6508.08886755864;6510.609363438209;6511.120998665119;6512.381323774234;6512.967435162794;6514.6416947068365;6526.053722210348;6566;6621.039949207434;6621.635810030494;6671.532992690465;6757.763478278237;6563;6594.208694956444;6620.867582648417;6624.735010599715;6631.403173714389 02:38:11 INFO - PID 7201 | |1;ext.html;797.6849144587887;837.991620083799;863.0937515608609;885.5350940756106;888.5823662878449;39824;40729;40842.79578602103;40856.59143408565;40871.795641021825;37082.07294817631;37323.813380933054;37371.439428408594;37390.8130459348;37403.62596374036;6947.166340039203;7029.156501219861;7039.54242974205;7042;7045;6913.827154321132;6988.196357418911;6991.685374158175;6995.930040699604;6999.615021173833;6980.092587963558;7605.239476052406;7795.298423141944;7802.453828232026;7803.687852485894;7678.69285228593;7698.384129269673;7702.191269916634;7704.306612404883;7708.267714567107;7503.887441688379;7562.357199638037;7648.885266721004;7655.464117511777;7679.654415551314;37527.24945501102;37746;37934.43098353527;37977.430338544946;37984.24031519354;3433.5536380270655;3509.6841284284283;3518.4546395308766;3530.6645868642436;3539.256756081226;30782.692173078205;31055.84472077625;31058.689413105807;31088.533671994937;31094;5177.896442071137;5188.040212560688;5190.091733946582;5215.217717342391;5215.895682086337;176411;179269;182581;183805;198021;47304.763476183085;47678.28482572764;47686;47758.656894017084;47826.28260576094;50019.24971125436;50119.49880501221;50148.24777628339;50172.24741628879;50188.49811501838;15466;15546.067235965653;15569;15585.454509092127;15776.13231272291;12890.162139461092;12894.613161605166;12902.67743306425;12927.353632318347;12930.547430839875;13941.163530188222;14132.929335353258;14158.50445234412;14196.14823110596;14265.57203283903;5860.443257890493;5924.081767326072;5971.5222782177325;5972.431854302691;5981.192539007178;1020.6121673764071;1033.075397519216;1034.9948250258851;1039.8544203811473;1049.239301506417;22738.20416285422;22891.542169156524;22901.19845805389;22971.358293796427;22987.425314367276;1104.8066588347167;1121.9270747401392;1130.1687280120398;1134.4271143072694;1134.6655774939652;11884.702882428008;12189.84196501331;12218.755624887452;12236.021118310513;12287.262764234174;217697;220154;220669;220703;221069;51942;51962.22056669153;52001.7399912998;52109.218361724605;52226.73886630542;1439.3235179465635;1464.3410465290663;1471.6762312291278;1474.0492382413283;1476.1364601708121;22321.77678223262;22734.317970460914;22839.885800571556;22885.08459661595;23154.652680209474;37329.25341493209;37338.6266137346;37412.625873740915;37453.4381984265;37594.24811503809;195029;195800;196073;196208;196227;29619.111426657233;30115.54826677558;32430;33453;33585;40858.38712419375;42304.78847605742;42831.57168428276;43066.56933430626;43432.565674342855;31207.84396078005;31209.531857022615;31348;31618.683813162494;31748.523772143897;31118.84440577873;31142;31470.055898323088;31510.684893150774;31888.202794930312;35297.823510882285;35301.646983529834;35330.47004294989;35451.468227977115;38217.426738598384;32830;32842.343153137284;32934.83532582322;33155.668443315255;33336.33327333391;23800.761992380547;23846.284611461684;24579.03570414697;24637.507249854545;24656.753432466165 02:38:11 INFO - PID 7201 | |2;jquery.html;556.3713004305134;558.6396774080717;570.3355590736792;588.1501230721608;592.2715060475615;22166.778332216672;22467.662985055238;23050.423739406524;23070.538589228225;23082.192123275647;26582.468350632975;27090;27203.591946120825;27210.45579088417;27230.45539089217;7154.463415243851;7321.670524826369;7337.88993165103;7353.52202106864;7356.74251401201;6828.419584335337;7125.073740413739;7200.675969581355;7216.8917466238045;7291.161516425599;7126.572405655677;7147.535410198347;7148.642567871611;7149.53528020677;7150.10623672041;7135.322144396274;7142.642867856613;7145.571265724073;7154.892676609855;7166.749163779295;7016.36852683261;7019.5086343955945;7025.332593403618;7035.92964070363;7037.296270372973;30319;30766.846165769253;31506;31598.842005790055;31731.365372692417;2080.916763329465;2109.694094356325;2110.5884352551257;2115.4394085567337;2116.67191585303;20607.175712971464;21193.258235961668;21201.363959081253;21214.681779773317;21244;2517.7230504644476;2564.230730780758;2661.38788078743;2665.520206362854;2678.517866783978;126851;131602.99999999904;131782.3410882949;132061.33969330092;132248;19761.505962351057;20809;20858.582828343348;21436.78563214379;22159;21750.89124554367;23089.76910230876;23175;23178.884105579364;42036.36945445821;10094.394336339843;10156.542955567018;10297.433641149659;10431.94784026075;10534.20993425496;9519.190868776093;9534.809303813885;9604.66383676568;9649.758756031155;9743.561539730728;9221.907780922105;9222.170004699476;9271.90728092724;9360;9469.90530094704;2673.278214881971;2683.825551339157;2808.8314701117997;2823.491771481153;2845.9573106403423;890.8663700444855;937.95310234488;957.8563215517589;958.5878072428783;963.0995019656643;19031.333903313596;19381.612367752565;19431.611367772566;19474.8052519473;19709.901450492656;992.9106380425796;1025.9435731034864;1027.3784360461962;1030.258214085857;1031.1544533482472;10434.895651043544;10870.728231794268;10882.945585272022;10998.670039898816;11005.724856878482;490828;493567;505849;509201;510070;114012;116708;117702;118533;118806;1141.1384404774508;1155.8035134027236;1180.1974657232993;1180.893719565226;1180.9114316426303;17157.57106072358;17231;17442.127893605524;17743.556411089827;17832.3758668446;53411.732941335045;54359.72820135874;54744.45255547394;54800.45199547953;55866.72066639803;70199.64900175671;72262.63868680623;74037.6298118506;74214.62892685502;75039.62480187565;13904.51334203298;14217.573472795833;14302.141871487744;14319.570412887213;14352.425902963765;22148.88925555362;22231.777252251282;22263.109475620793;22314.330570082922;22430.102795888633;17629.647407051532;17773.911130444267;17824.287028518713;18065.09674516295;18200.99894505815;15670.608234794221;16046.197690115681;16513;16524.504264872074;16604.58488537796;18358;18360.265589376275;18617.162227699515;18677.252909883453;19668.21327146898;14615.123092614476;14777.113373197213;14781.260936952895;14841.332140053508;14875.330610122353;17190.742138868176;17677.558061048578;18766.906165469085;18802.623947521246;18915 02:38:11 INFO - PID 7201 | |3;mootools.html;1347.8315210598676;1377.2562816079317;1403.4736973634888;1409.880160186384;1416.5325442603948;15112.244387780609;15305.540833775005;15666;15781;15800.60498487537;15808.367665293403;15924.203789810492;15937.282822272997;16034.59913502163;16079.758803617926;2736.192823117185;2767.8892844286306;2772.279207406079;2775.3755405033808;2798.1885253276523;2651.973480265192;2660.5477068898235;2734.9589756153673;2741.1091395296608;2748.477789220042;2743.1633351827686;2789.888404463819;2792.8184667996616;2809.1291699573094;2809.887604495818;2655.150351887397;2687.543117670001;2697.460507898428;2698.9595156072673;2700.621912932191;2668.6931002934716;2673.585594232897;2698.37937274428;2698.6221928929967;2699.2172270041665;14893.925530372388;15272.618184545365;15273.159976201305;15290.541283761506;15378.692426151414;7936.246056624612;8226.300764435031;8247.546384948826;8251.092379838214;8256.339492840558;5278.973605131988;5295.602829787743;5554.1391084381985;5663.377028526858;5666.263385759866;1860.7022876339856;1886.9056547172725;1916.5400303927097;1946.9221231150736;1953.736245606839;26902.865485672643;26993.460130797273;27201;27270.45459090827;27276.181714548595;6824.727010919508;6841.17905851301;6883.793486195422;6963.4777391695825;7051.823704407431;17661.29354825818;17664.381746638806;17665.38171164003;17682;17693.823061769475;7885.1326354101;8169.346452283803;8366.790830229293;8402.663893444194;8421.915780842113;7423.777286681408;7440.404767618686;7473.4021278297605;7475.289847464483;7521.887171692429;5000.149914548672;5128.461511541309;5157.948420515747;5186.5332120108615;5193.506616871467;1317.4005827348533;1319.729455461628;1442.9855701443062;1448.739226939161;1453.7237924794256;896.7578753736585;922.1055576091181;925.6251218256617;927.5918595817818;939.6992962252014;8197.34421246299;8496.745097647081;8512.957435212908;8517.829643407222;8534.061253262136;993.8906720260766;1013.083159740436;1018.495844556949;1028.2339656955467;1028.8096702110133;5067.1639179535705;5103.157978933508;5118.078745825713;5143.588512918957;5224.346956630421;21840.45398865041;22490.887545562495;22502.549949000928;22701.65947510789;22896.65655015176;20646.380608581767;21943.780562194494;22267.220647277267;22407;22423.21518746836;11267.436628168558;11613.187076904704;11655.18413711032;11739.002184814215;11744.17790754639;8434.493930364199;8583.613737381958;8733.170348816851;8819.867701984347;9003.414778039407;18233.544161396072;18474.907625461787;18639.440816775517;18860.24559017624;19231;19251.22995080181;19316.130774114918;19386.90306548458;19537.804621953597;19591.118399672334;11370.374629395463;11448.198626096426;11496.770064598828;11595.5941542049;11600.709982250512;13425;13590.116642418212;13611.931940340632;13615.387307570985;13619.31903404806;11201.60794372193;11208.439578021229;11270.94364528172;11339.262947908359;11485.655430337103;10907.618233361794;11029.83455248188;11066.28069175501;11185.776284474428;11292.943535282271;9440.95279523598;9623.56693948788;9633.421994680342;9638.325317228007;9657;7338.633068346669;7398.038255026812;7464.216257293123;7483.738069167553;7488.775336739906;7368.963155184189;7456.627168641655;7477.92522074794;7565.735199268;7581.279778421042 02:38:11 INFO - PID 7201 | |4;prototype.html;502.745187832571;504.30657845462514;525.1597444089457;525.9815906443271;535.3361831329153;6261.248650161976;6301.6534090625;6357.23713154421;6368.7452501899925;6469.935300646992;6141.662208578527;6143.2628084629905;6183.350748171445;6287.811365659026;6297.2128483939505;5025.84922452327;5054.873628159307;5067.391912970449;5072.3405957225605;5108.438071812097;4896.77964491597;4999.500049994989;5009.198528235483;5100.1074811907765;5101.438841727407;4925.581325587312;4964.726940018298;5005.1491246488;5035.974820125894;5059.2916991621205;4966.453690094087;4996.500349965011;5012.949870501303;5037.722925239111;5086.237064440364;4448.866534003985;4490.169318676056;4526.366308716782;4528.977355113237;4531.456225252958;6226.719797609118;6230.844228894314;6287.8742425151695;6289.8742025159245;6311.810645680637;5740.56945729072;5757.136429535562;5759.971200144015;5767.279090113736;5855.180274761537;6666.233383160901;6708.362705542965;6719.697613607351;6725.899111513331;6743.629100399476;4883.731394773286;4894.583960363373;4897.436794768611;4925.3597032385915;4926.679765815211;7087.929120708778;7093.3970612498;7132.393746531551;7158.821029474305;7172.103487064117;5027.4721154279005;5067.163917953497;5075.893504195791;5077.771500282496;5095.923561146586;5089.491050894955;5142.1772516397195;5152.742362881841;5179.326687530673;5201.609879259071;5797.507211886952;5827.562932780059;5854.2096816930025;5875.441833025856;5877.706114694333;6594.823708176386;6631.33686631333;6649.60102393858;6726.932730672631;6849.732799432121;1656.3954156732946;1700.5663555793194;1719.6474722681821;1774.7160454327504;1775.6715007723612;1210.939453027345;1215.1251099208555;1226.4174517104304;1239.1759479945915;1245.5578269714301;5770.798022069207;5791.5656325775735;5872.324682661549;5894.351621321651;5916.615419997686;6720.831979200461;6742.561733487406;6765.898511522331;6885.896711549331;6925.6190909500465;5837.22731702438;5921.496672782861;5921.795525177086;5974.2830860297045;5983.401659833982;3569.1255642367787;3645.9582633724667;3650.1604630935035;3684.373656478405;3696.0205545530457;6590.538662293593;6682.465402767767;6690.220025685472;6709.396154346132;6744.494162937799;7028.856198859397;7052.224255331909;7073.823154421078;7162.994361578766;7201.207867134611;6558.311377305409;6632.303608121174;6659.933400665931;6663.766768163091;6727.461803055744;6762.8647427052165;6825.897611535732;6856.862862742618;6872;6926;6783.152105986752;6794.898076528757;6804.081449004321;6859.176898772179;6936.930630693831;6642.701078451385;6657.434118099822;6690.397864192246;6703.787750042572;6722.6638668065425;5524.259858144672;5547.972260138835;5563.916541251803;5591.161325801162;5615.241942337732;6587.934120658732;6792.93207067923;6830.248672646105;6858.794236172923;6930;6280;6614.206295244601;6637.668116594247;6648.767293144717;6652.966735166293;6631;6646.7341306349135;6659.167604049494;6679.9332006679315;6708.19501659804;6571.704273307617;6598.406143447113;6599.208095028627;6628.734850605922;6641.535092543476;6560.770373037111;6636.568623039487;6659.801235777607;6679.56582822115;6733.764318248838;6392.712327945161;6433.260175079926;6498.870022599616;6510.902336465051;6543.934560654333 02:38:11 INFO - PID 7201 | |5;yui.html;892.5581836990691;904.8506996345603;913.9954300228497;914.2594498456247;917.756794449471;18682.34611788586;19549;19641;19651.705224421647;21738.3478495645;20442.2845200418;21733.45666358342;21836.8908155459;21986.45033874154;22025.118995240213;957.3585697582619;979.485769970764;982.2878413150445;983.2772911909741;983.6458874805064;941.6186444489958;983.9311248212628;986.842105263158;987.7728122531786;987.9456629885353;1027.5581499955017;1042.3381152967845;1042.5517027678095;1043.9739006524821;1044.7597052677888;1040.9115225205828;1041.448032542746;1041.781225942553;1041.8489319048733;1042.1975079189058;769.7113582406597;771.2210667226086;771.4252881603186;771.9073711154641;772.0966469230957;17795.377161799406;18022.36921707734;18210.817891821178;18215.726764098417;19576.02119894014;20040.1983920643;20057.598848023103;20514.076866541043;20523.384298471068;20562.897185514128;16256.51230463088;16338.75491867623;16412.343506259735;16505.422310219205;16560.917195414066;3688;3705.4256590228556;3707.9814600927093;3714.7771133732062;3726.441033844918;117877.41061294639;118627.40686296599;118870;119818.40090799578;121569.39215303956;16435.424760133577;16947.983121012778;16979.83020169807;17010.914945425193;17030.233639486254;29061.709382906323;30434.69565304363;30792.538111928337;30802.229944251125;30833.537496937563;8703.521306328214;8995.415298005608;8998.955005225063;9046.095390460901;9098.454092754457;4479.216137175981;4536.387587675687;4569.9314510282375;4581.610563102107;4584.77076146198;5118.411382691038;5238.2404551340605;5668.773249070074;5898.262717160355;5923.851903702356;1120.2998126171144;1122.2705241592867;1145.1125377832248;1147.1052578988401;1151.424287856072;663.4625952978104;678.0845858091537;691.5539477037282;696.0776970514089;698.3051863395954;10556.577736890438;10961.725956850983;11360.886391136148;11982.041436685044;12312.322822244863;668.7659319238325;674.7132468700783;682.7849227493324;683.7641013850214;688.6591137387026;5584.21820945068;5708.372079071299;5731.426857314235;5758.913616295759;5816.1566572846705;105760;108867.45566272276;109101.45449272703;109713;111723;104924;105011.47494262633;106180;107971.46014269878;111091.44454277838;90961.54519227493;91718.08281917228;93038.53480732688;95033.52483237677;95058.04941950631;10198.694039178836;10362.533685983997;10362.844557331495;10530.040971758348;10761.139108871115;37638.24723505569;42119;44106.77946610247;45229.547704522534;45506;77311.2268877304;79609;79894.60052699699;80429.19570804217;81086;18024.81975180284;18501.72247416263;18563.25746970106;18586.81413185905;18864.151113200212;19976.20095196176;19985.30051448192;19989.500262493555;20018.399448016582;20131.79868201299;17538.386156484463;17748.20133093988;17828.821711783236;17866;18021.909890450464;16697.666046678754;17055;17097.401590944257;17130.314787408362;17266.91366543159;16508.75236871424;16579.50261492157;16661.416850410176;16770.496885093467;16809.831901680827;12193.207441516273;12271.447784849524;12426.130170887951;12582.937085314516;12681.80977285323;11987.64037078889;12095.455704493143;12115.575954841539;12122;12306 02:38:11 INFO - PID 7201 | __end_tp_report 02:38:11 INFO - PID 7201 | __start_cc_report 02:38:11 INFO - PID 7201 | _x_x_mozilla_cycle_collect,363 02:38:11 INFO - PID 7201 | __end_cc_report 02:38:11 INFO - PID 7201 | __startTimestamp1504258691949__endTimestamp 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | ------- Summary: start ------- 02:38:11 INFO - PID 7201 | Number of tests: 6 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#0] dojo.html Cycles:165 Average:6321.76 Median:6519.67 stddev:748.96 (11.5%) stddev-sans-first:712.17 02:38:11 INFO - PID 7201 | Values: 3277.6 3316.3 3341.2 3348.0 3385.1 6245.0 6386.4 6519.7 6527.3 6561.0 6153.4 6239.1 6256.5 6266.9 6292.9 5784.9 5794.0 5885.5 5919.9 5983.9 5962.2 5996.3 6002.6 6009.6 6049.7 5764.9 5824.3 5846.3 5965.2 5970.9 5826.9 5898.3 5934.2 5963.5 5967.2 5780.2 5802.8 5823.5 5830.4 5838.5 6390.7 6398.7 6399.6 6403.6 6415.5 6840.7 6888.2 6953.1 6955.3 6973.3 6592.8 6900.3 6913.6 7000.4 7006.6 6293.8 6302.4 6307.7 6311.5 6311.9 6952.5 7128.2 7136.5 7186.6 7244.8 6820.0 6885.4 6896.5 6899.1 6901.8 6927.1 6940.8 6968.2 7041.8 7059.4 6529.2 6611.7 6621.8 6633.8 6645.7 6656.8 6674.6 6759.6 6930.1 6939.5 5400.2 5402.8 5402.9 5410.1 5416.6 4691.1 4731.2 4738.4 4742.4 4747.3 5799.6 5867.4 5916.7 5957.8 6013.4 6956.2 6984.5 7020.5 7046.4 7049.4 6028.8 6030.6 6042.9 6102.6 6110.3 5904.4 5919.4 5989.5 5996.6 5998.3 6486.0 6580.4 6629.9 6752.4 6753.0 6917.6 6934.5 6977.0 6981.3 7005.0 6575.0 6665.9 6697.8 6760.5 6762.9 6568.3 6808.2 6810.4 6900.8 6910.6 6824.8 6952.8 7031.4 7033.7 7034.8 6728.8 6746.4 6816.2 6818.1 6828.6 6411.2 6501.3 6504.4 6508.1 6510.6 6511.1 6512.4 6513.0 6514.6 6526.1 6566.0 6621.0 6621.6 6671.5 6757.8 6563.0 6594.2 6620.9 6624.7 6631.4 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#1] ext.html Cycles:180 Average:36692.70 Median:3471.62 stddev:51917.46 (1495.5%) stddev-sans-first:51993.14 02:38:11 INFO - PID 7201 | Values: 797.7 838.0 863.1 885.5 888.6 39824.0 40729.0 40842.8 40856.6 40871.8 37082.1 37323.8 37371.4 37390.8 37403.6 6947.2 7029.2 7039.5 7042.0 7045.0 6913.8 6988.2 6991.7 6995.9 6999.6 6980.1 7605.2 7795.3 7802.5 7803.7 7678.7 7698.4 7702.2 7704.3 7708.3 7503.9 7562.4 7648.9 7655.5 7679.7 37527.2 37746.0 37934.4 37977.4 37984.2 3433.6 3509.7 3518.5 3530.7 3539.3 30782.7 31055.8 31058.7 31088.5 31094.0 5177.9 5188.0 5190.1 5215.2 5215.9 176411.0 179269.0 182581.0 183805.0 198021.0 47304.8 47678.3 47686.0 47758.7 47826.3 50019.2 50119.5 50148.2 50172.2 50188.5 15466.0 15546.1 15569.0 15585.5 15776.1 12890.2 12894.6 12902.7 12927.4 12930.5 13941.2 14132.9 14158.5 14196.1 14265.6 5860.4 5924.1 5971.5 5972.4 5981.2 1020.6 1033.1 1035.0 1039.9 1049.2 22738.2 22891.5 22901.2 22971.4 22987.4 1104.8 1121.9 1130.2 1134.4 1134.7 11884.7 12189.8 12218.8 12236.0 12287.3 217697.0 220154.0 220669.0 220703.0 221069.0 51942.0 51962.2 52001.7 52109.2 52226.7 1439.3 1464.3 1471.7 1474.0 1476.1 22321.8 22734.3 22839.9 22885.1 23154.7 37329.3 37338.6 37412.6 37453.4 37594.2 195029.0 195800.0 196073.0 196208.0 196227.0 29619.1 30115.5 32430.0 33453.0 33585.0 40858.4 42304.8 42831.6 43066.6 43432.6 31207.8 31209.5 31348.0 31618.7 31748.5 31118.8 31142.0 31470.1 31510.7 31888.2 35297.8 35301.6 35330.5 35451.5 38217.4 32830.0 32842.3 32934.8 33155.7 33336.3 23800.8 23846.3 24579.0 24637.5 24656.8 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#2] jquery.html Cycles:180 Average:35385.11 Median:22448.88 stddev:84154.76 (374.9%) stddev-sans-first:84350.21 02:38:11 INFO - PID 7201 | Values: 556.4 558.6 570.3 588.2 592.3 22166.8 22467.7 23050.4 23070.5 23082.2 26582.5 27090.0 27203.6 27210.5 27230.5 7154.5 7321.7 7337.9 7353.5 7356.7 6828.4 7125.1 7200.7 7216.9 7291.2 7126.6 7147.5 7148.6 7149.5 7150.1 7135.3 7142.6 7145.6 7154.9 7166.7 7016.4 7019.5 7025.3 7035.9 7037.3 30319.0 30766.8 31506.0 31598.8 31731.4 2080.9 2109.7 2110.6 2115.4 2116.7 20607.2 21193.3 21201.4 21214.7 21244.0 2517.7 2564.2 2661.4 2665.5 2678.5 126851.0 131603.0 131782.3 132061.3 132248.0 19761.5 20809.0 20858.6 21436.8 22159.0 21750.9 23089.8 23175.0 23178.9 42036.4 10094.4 10156.5 10297.4 10431.9 10534.2 9519.2 9534.8 9604.7 9649.8 9743.6 9221.9 9222.2 9271.9 9360.0 9469.9 2673.3 2683.8 2808.8 2823.5 2846.0 890.9 938.0 957.9 958.6 963.1 19031.3 19381.6 19431.6 19474.8 19709.9 992.9 1025.9 1027.4 1030.3 1031.2 10434.9 10870.7 10882.9 10998.7 11005.7 490828.0 493567.0 505849.0 509201.0 510070.0 114012.0 116708.0 117702.0 118533.0 118806.0 1141.1 1155.8 1180.2 1180.9 1180.9 17157.6 17231.0 17442.1 17743.6 17832.4 53411.7 54359.7 54744.5 54800.5 55866.7 70199.6 72262.6 74037.6 74214.6 75039.6 13904.5 14217.6 14302.1 14319.6 14352.4 22148.9 22231.8 22263.1 22314.3 22430.1 17629.6 17773.9 17824.3 18065.1 18201.0 15670.6 16046.2 16513.0 16524.5 16604.6 18358.0 18360.3 18617.2 18677.3 19668.2 14615.1 14777.1 14781.3 14841.3 14875.3 17190.7 17677.6 18766.9 18802.6 18915.0 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#3] mootools.html Cycles:180 Average:9490.52 Median:14800.16 stddev:6827.06 (46.1%) stddev-sans-first:6818.80 02:38:11 INFO - PID 7201 | Values: 1347.8 1377.3 1403.5 1409.9 1416.5 15112.2 15305.5 15666.0 15781.0 15800.6 15808.4 15924.2 15937.3 16034.6 16079.8 2736.2 2767.9 2772.3 2775.4 2798.2 2652.0 2660.5 2735.0 2741.1 2748.5 2743.2 2789.9 2792.8 2809.1 2809.9 2655.2 2687.5 2697.5 2699.0 2700.6 2668.7 2673.6 2698.4 2698.6 2699.2 14893.9 15272.6 15273.2 15290.5 15378.7 7936.2 8226.3 8247.5 8251.1 8256.3 5279.0 5295.6 5554.1 5663.4 5666.3 1860.7 1886.9 1916.5 1946.9 1953.7 26902.9 26993.5 27201.0 27270.5 27276.2 6824.7 6841.2 6883.8 6963.5 7051.8 17661.3 17664.4 17665.4 17682.0 17693.8 7885.1 8169.3 8366.8 8402.7 8421.9 7423.8 7440.4 7473.4 7475.3 7521.9 5000.1 5128.5 5157.9 5186.5 5193.5 1317.4 1319.7 1443.0 1448.7 1453.7 896.8 922.1 925.6 927.6 939.7 8197.3 8496.7 8513.0 8517.8 8534.1 993.9 1013.1 1018.5 1028.2 1028.8 5067.2 5103.2 5118.1 5143.6 5224.3 21840.5 22490.9 22502.5 22701.7 22896.7 20646.4 21943.8 22267.2 22407.0 22423.2 11267.4 11613.2 11655.2 11739.0 11744.2 8434.5 8583.6 8733.2 8819.9 9003.4 18233.5 18474.9 18639.4 18860.2 19231.0 19251.2 19316.1 19386.9 19537.8 19591.1 11370.4 11448.2 11496.8 11595.6 11600.7 13425.0 13590.1 13611.9 13615.4 13619.3 11201.6 11208.4 11270.9 11339.3 11485.7 10907.6 11029.8 11066.3 11185.8 11292.9 9441.0 9623.6 9633.4 9638.3 9657.0 7338.6 7398.0 7464.2 7483.7 7488.8 7369.0 7456.6 7477.9 7565.7 7581.3 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#4] prototype.html Cycles:180 Average:5626.99 Median:6270.62 stddev:1589.04 (25.3%) stddev-sans-first:1546.25 02:38:11 INFO - PID 7201 | Values: 502.7 504.3 525.2 526.0 535.3 6261.2 6301.7 6357.2 6368.7 6469.9 6141.7 6143.3 6183.4 6287.8 6297.2 5025.8 5054.9 5067.4 5072.3 5108.4 4896.8 4999.5 5009.2 5100.1 5101.4 4925.6 4964.7 5005.1 5036.0 5059.3 4966.5 4996.5 5012.9 5037.7 5086.2 4448.9 4490.2 4526.4 4529.0 4531.5 6226.7 6230.8 6287.9 6289.9 6311.8 5740.6 5757.1 5760.0 5767.3 5855.2 6666.2 6708.4 6719.7 6725.9 6743.6 4883.7 4894.6 4897.4 4925.4 4926.7 7087.9 7093.4 7132.4 7158.8 7172.1 5027.5 5067.2 5075.9 5077.8 5095.9 5089.5 5142.2 5152.7 5179.3 5201.6 5797.5 5827.6 5854.2 5875.4 5877.7 6594.8 6631.3 6649.6 6726.9 6849.7 1656.4 1700.6 1719.6 1774.7 1775.7 1210.9 1215.1 1226.4 1239.2 1245.6 5770.8 5791.6 5872.3 5894.4 5916.6 6720.8 6742.6 6765.9 6885.9 6925.6 5837.2 5921.5 5921.8 5974.3 5983.4 3569.1 3646.0 3650.2 3684.4 3696.0 6590.5 6682.5 6690.2 6709.4 6744.5 7028.9 7052.2 7073.8 7163.0 7201.2 6558.3 6632.3 6659.9 6663.8 6727.5 6762.9 6825.9 6856.9 6872.0 6926.0 6783.2 6794.9 6804.1 6859.2 6936.9 6642.7 6657.4 6690.4 6703.8 6722.7 5524.3 5548.0 5563.9 5591.2 5615.2 6587.9 6792.9 6830.2 6858.8 6930.0 6280.0 6614.2 6637.7 6648.8 6653.0 6631.0 6646.7 6659.2 6679.9 6708.2 6571.7 6598.4 6599.2 6628.7 6641.5 6560.8 6636.6 6659.8 6679.6 6733.8 6392.7 6433.3 6498.9 6510.9 6543.9 02:38:11 INFO - PID 7201 | 02:38:11 INFO - PID 7201 | [#5] yui.html Cycles:180 Average:24117.37 Median:19987.40 stddev:33002.01 (165.1%) stddev-sans-first:33048.51 02:38:11 INFO - PID 7201 | Values: 892.6 904.9 914.0 914.3 917.8 18682.3 19549.0 19641.0 19651.7 21738.3 20442.3 21733.5 21836.9 21986.5 22025.1 957.4 979.5 982.3 983.3 983.6 941.6 983.9 986.8 987.8 987.9 1027.6 1042.3 1042.6 1044.0 1044.8 1040.9 1041.4 1041.8 1041.8 1042.2 769.7 771.2 771.4 771.9 772.1 17795.4 18022.4 18210.8 18215.7 19576.0 20040.2 20057.6 20514.1 20523.4 20562.9 16256.5 16338.8 16412.3 16505.4 16560.9 3688.0 3705.4 3708.0 3714.8 3726.4 117877.4 118627.4 118870.0 119818.4 121569.4 16435.4 16948.0 16979.8 17010.9 17030.2 29061.7 30434.7 30792.5 30802.2 30833.5 8703.5 8995.4 8999.0 9046.1 9098.5 4479.2 4536.4 4569.9 4581.6 4584.8 5118.4 5238.2 5668.8 5898.3 5923.9 1120.3 1122.3 1145.1 1147.1 1151.4 663.5 678.1 691.6 696.1 698.3 10556.6 10961.7 11360.9 11982.0 12312.3 668.8 674.7 682.8 683.8 688.7 5584.2 5708.4 5731.4 5758.9 5816.2 105760.0 108867.5 109101.5 109713.0 111723.0 104924.0 105011.5 106180.0 107971.5 111091.4 90961.5 91718.1 93038.5 95033.5 95058.0 10198.7 10362.5 10362.8 10530.0 10761.1 37638.2 42119.0 44106.8 45229.5 45506.0 77311.2 79609.0 79894.6 80429.2 81086.0 18024.8 18501.7 18563.3 18586.8 18864.2 19976.2 19985.3 19989.5 20018.4 20131.8 17538.4 17748.2 17828.8 17866.0 18021.9 16697.7 17055.0 17097.4 17130.3 17266.9 16508.8 16579.5 16661.4 16770.5 16809.8 12193.2 12271.4 12426.1 12582.9 12681.8 11987.6 12095.5 12115.6 12122.0 12306.0 02:38:11 INFO - PID 7201 | -------- Summary: end -------- 02:38:11 INFO - PID 7201 | 02:38:12 INFO - TEST-INFO | 7201: exit 0 02:38:12 INFO - TEST-OK | dromaeo_css | took 1111031ms 02:38:12 INFO - TEST-START | kraken 02:38:12 INFO - Initialising browser for kraken test... 02:38:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57267/getInfo.html -profile /tmp/tmpmenelI/profile 02:38:12 INFO - TEST-INFO | started process 7574 (/builds/slave/test/build/application/firefox/firefox http://localhost:57267/getInfo.html) 02:38:18 INFO - TEST-INFO | 7574: exit 0 02:38:18 INFO - Browser initialized. 02:38:18 INFO - Running cycle 1/1 for kraken test... 02:38:18 INFO - Using env: {'DISPLAY': ':0', 02:38:18 INFO - 'HOME': '/home/cltbld', 02:38:18 INFO - 'JSGC_DISABLE_POISONING': '1', 02:38:18 INFO - 'LANG': 'en_US.UTF-8', 02:38:18 INFO - 'LANGUAGE': 'en_US:en', 02:38:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:38:18 INFO - 'LOGNAME': 'cltbld', 02:38:18 INFO - 'MAIL': '/var/mail/cltbld', 02:38:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:18 INFO - 'MOZ_CRASHREPORTER': '1', 02:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:38:18 INFO - 'MOZ_NO_REMOTE': '1', 02:38:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:18 INFO - 'NO_EM_RESTART': '1', 02:38:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:18 INFO - 'PWD': '/builds/slave/test', 02:38:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:18 INFO - 'RUST_BACKTRACE': 'full', 02:38:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:18 INFO - 'SHELL': '/bin/bash', 02:38:18 INFO - 'SHLVL': '1', 02:38:18 INFO - 'TERM': 'linux', 02:38:18 INFO - 'TMOUT': '86400', 02:38:18 INFO - 'USER': 'cltbld', 02:38:18 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036', 02:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:18 INFO - '_': '/tools/buildbot/bin/python'} 02:38:18 INFO - TEST-INFO | started process 7759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmenelI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:19 INFO - PID 7759 | 02:38:19 INFO - PID 7759 | (/builds/slave/test/build/application/firefox/firefox:7810): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:38:19 INFO - PID 7759 | 02:38:30 INFO - PID 7759 | RSS: Main: 165232640 02:38:30 INFO - PID 7759 | 02:38:32 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:33 INFO - PID 7759 | RSS: Main: 169893888 02:38:33 INFO - PID 7759 | 02:38:36 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-dft) 02:38:36 INFO - PID 7759 | RSS: Main: 171433984 02:38:36 INFO - PID 7759 | 02:38:39 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-fft) 02:38:40 INFO - PID 7759 | RSS: Main: 165416960 02:38:40 INFO - PID 7759 | 02:38:42 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57267/tests/kraken/driver.html?testName=audio-oscillator) 02:38:43 INFO - PID 7759 | RSS: Main: 165965824 02:38:43 INFO - PID 7759 | 02:38:45 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:46 INFO - PID 7759 | RSS: Main: 166694912 02:38:46 INFO - PID 7759 | 02:38:49 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:49 INFO - PID 7759 | RSS: Main: 169136128 02:38:49 INFO - PID 7759 | 02:38:53 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57267/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:53 INFO - PID 7759 | RSS: Main: 169431040 02:38:53 INFO - PID 7759 | 02:38:56 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57267/tests/kraken/driver.html?testName=json-parse-financial) 02:38:57 INFO - PID 7759 | RSS: Main: 169119744 02:38:57 INFO - PID 7759 | 02:38:59 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:38:59 INFO - PID 7759 | RSS: Main: 168824832 02:38:59 INFO - PID 7759 | 02:39:01 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:01 INFO - PID 7759 | RSS: Main: 169570304 02:39:01 INFO - PID 7759 | 02:39:03 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:04 INFO - PID 7759 | RSS: Main: 169013248 02:39:04 INFO - PID 7759 | 02:39:07 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:08 INFO - PID 7759 | RSS: Main: 169029632 02:39:08 INFO - PID 7759 | 02:39:10 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:11 INFO - PID 7759 | RSS: Main: 169476096 02:39:11 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | Cycle 1(1): loaded http://localhost:57267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57267/tests/kraken/driver.html?testName=ai-astar) 02:39:13 INFO - PID 7759 | RSS: Main: 170991616 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | __start_tp_report 02:39:13 INFO - PID 7759 | _x_x_mozilla_page_load 02:39:13 INFO - PID 7759 | _x_x_mozilla_page_load_details 02:39:13 INFO - PID 7759 | |i|pagename|runs| 02:39:13 INFO - PID 7759 | |0;ai-astar;97;115;99;106;107;109;114;98;107;108 02:39:13 INFO - PID 7759 | |1;audio-beat-detection;167;117;146;171;116;144;151;120;170;117 02:39:13 INFO - PID 7759 | |2;audio-dft;163;163;162;161;162;162;163;162;167;162 02:39:13 INFO - PID 7759 | |3;audio-fft;76;74;76;175;75;74;76;74;170;75 02:39:13 INFO - PID 7759 | |4;audio-oscillator;79;79;131;79;79;80;127;79;80;133 02:39:13 INFO - PID 7759 | |5;imaging-gaussian-blur;114;114;113;114;114;114;114;113;114;114 02:39:13 INFO - PID 7759 | |6;imaging-darkroom;148;150;147;149;150;147;148;147;148;148 02:39:13 INFO - PID 7759 | |7;imaging-desaturate;94;94;94;94;94;96;95;93;94;94 02:39:13 INFO - PID 7759 | |8;json-parse-financial;53;53;52;54;52;52;54;55;53;57 02:39:13 INFO - PID 7759 | |9;json-stringify-tinderbox;38;38;38;38;37;37;42;38;38;37 02:39:13 INFO - PID 7759 | |10;stanford-crypto-aes;76;74;76;75;76;74;76;75;75;78 02:39:13 INFO - PID 7759 | |11;stanford-crypto-ccm;126;116;118;123;122;121;120;117;118;161 02:39:13 INFO - PID 7759 | |12;stanford-crypto-pbkdf2;171;174;167;176;177;171;170;174;179;173 02:39:13 INFO - PID 7759 | |13;stanford-crypto-sha256-iterative;65;65;65;67;63;63;65;70;62;63 02:39:13 INFO - PID 7759 | __end_tp_report 02:39:13 INFO - PID 7759 | __start_cc_report 02:39:13 INFO - PID 7759 | _x_x_mozilla_cycle_collect,941 02:39:13 INFO - PID 7759 | __end_cc_report 02:39:13 INFO - PID 7759 | __startTimestamp1504258753590__endTimestamp 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | ------- Summary: start ------- 02:39:13 INFO - PID 7759 | Number of tests: 14 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#0] ai-astar Cycles:10 Average:106.00 Median:114.50 stddev:6.27 (5.5%) stddev-sans-first:5.74 02:39:13 INFO - PID 7759 | Values: 97.0 115.0 99.0 106.0 107.0 109.0 114.0 98.0 107.0 108.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:148.50 stddev:23.00 (15.5%) stddev-sans-first:22.53 02:39:13 INFO - PID 7759 | Values: 167.0 117.0 146.0 171.0 116.0 144.0 151.0 120.0 170.0 117.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.64 (1.0%) stddev-sans-first:1.73 02:39:13 INFO - PID 7759 | Values: 163.0 163.0 162.0 161.0 162.0 162.0 163.0 162.0 167.0 162.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.00 stddev:41.13 (54.8%) stddev-sans-first:43.08 02:39:13 INFO - PID 7759 | Values: 76.0 74.0 76.0 175.0 75.0 74.0 76.0 74.0 170.0 75.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:24.70 (31.3%) stddev-sans-first:25.55 02:39:13 INFO - PID 7759 | Values: 79.0 79.0 131.0 79.0 79.0 80.0 127.0 79.0 80.0 133.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:39:13 INFO - PID 7759 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 02:39:13 INFO - PID 7759 | Values: 148.0 150.0 147.0 149.0 150.0 147.0 148.0 147.0 148.0 148.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 02:39:13 INFO - PID 7759 | Values: 94.0 94.0 94.0 94.0 94.0 96.0 95.0 93.0 94.0 94.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:1.58 (3.0%) stddev-sans-first:1.67 02:39:13 INFO - PID 7759 | Values: 53.0 53.0 52.0 54.0 52.0 52.0 54.0 55.0 53.0 57.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:1.45 (3.8%) stddev-sans-first:1.54 02:39:13 INFO - PID 7759 | Values: 38.0 38.0 38.0 38.0 37.0 37.0 42.0 38.0 38.0 37.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:1.18 (1.6%) stddev-sans-first:1.24 02:39:13 INFO - PID 7759 | Values: 76.0 74.0 76.0 75.0 76.0 74.0 76.0 75.0 75.0 78.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:121.50 stddev:13.28 (10.9%) stddev-sans-first:14.07 02:39:13 INFO - PID 7759 | Values: 126.0 116.0 118.0 123.0 122.0 121.0 120.0 117.0 118.0 161.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.00 stddev:3.58 (2.1%) stddev-sans-first:3.71 02:39:13 INFO - PID 7759 | Values: 171.0 174.0 167.0 176.0 177.0 171.0 170.0 174.0 179.0 173.0 02:39:13 INFO - PID 7759 | 02:39:13 INFO - PID 7759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:2.35 (3.6%) stddev-sans-first:2.49 02:39:13 INFO - PID 7759 | Values: 65.0 65.0 65.0 67.0 63.0 63.0 65.0 70.0 62.0 63.0 02:39:13 INFO - PID 7759 | -------- Summary: end -------- 02:39:13 INFO - PID 7759 | 02:39:14 INFO - PID 7759 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:39:14 INFO - TEST-INFO | 7759: exit 0 02:39:14 INFO - TEST-OK | kraken | took 61704ms 02:39:14 INFO - SUITE-END | took 1172s 02:39:14 INFO - Completed test suite (00:19:33) 02:39:14 INFO - javascript benchmark 02:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8641.581454924397, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.5575297334867, 3316.303576248991, 3341.164708822795, 3347.9832600837, 3385.086026772771, 6244.968775156123, 6386.361363863617, 6519.674016299178, 6527.281998980108, 6561.048647946057, 6153.384661533844, 6239.095331176976, 6256.530760192981, 6266.905996410058, 6292.874142517158, 5784.913226301598, 5794.043982742843, 5885.470307672309, 5919.934411805873, 5983.940160598382, 5962.165296858421, 5996.2504686914135, 6002.639841609495, 6009.57932944694, 6049.727762250709, 5764.855878603026, 5824.330202026778, 5846.298444186704, 5965.1946987156825, 5970.940290597104, 5826.941730582682, 5898.292204935392, 5934.198883150784, 5963.493103086243, 5967.194428752106, 5780.16187652788, 5802.796672717507, 5823.505002074829, 5830.416958304136, 5838.503727183194, 6390.680465976682, 6398.680065996681, 6399.584027038228, 6403.551751377406, 6415.518836087312, 6840.6921688524135, 6888.173419189679, 6953.130858642669, 6955.304469553055, 6973.267806880306, 6592.835179120512, 6900.275471075565, 6913.619750913697, 7000.439964802855, 7006.649667516604, 6293.811185664437, 6302.432781049636, 6307.716152773136, 6311.526635502356, 6311.905321420182, 6952.548084374601, 7128.215896251409, 7136.464765142635, 7186.6047367395295, 7244.782656520313, 6820.04519367289, 6885.414739747077, 6896.517243792886, 6899.103116594811, 6901.792946211622, 6927.064846245692, 6940.826479337956, 6968.198657154492, 7041.788746337618, 7059.399951004222, 6529.151210342625, 6611.669416529155, 6621.834454138685, 6633.800985970429, 6645.667716614246, 6656.83357916056, 6674.599524028574, 6759.628220447824, 6930.06444130036, 6939.479539034593, 5400.162974738922, 5402.837914862561, 5402.864928376822, 5410.1343784994215, 5416.647917885325, 4691.13214055394, 4731.219348807477, 4738.360321356573, 4742.430908291027, 4747.264174053027, 5799.5650326225705, 5867.413258674099, 5916.7337469813965, 5957.821265362046, 6013.428724271187, 6956.165260168711, 6984.476164287698, 7020.473464490184, 7046.401055910305, 7049.365557099885, 6028.758849645965, 6030.577859549877, 6042.939570604326, 6102.572819902653, 6110.327863934964, 5904.409559044061, 5919.378465261086, 5989.520838332923, 5996.640201587918, 5998.280206375263, 6485.967570162119, 6580.440662543738, 6629.86740265192, 6752.358525940028, 6753.0, 6917.584944903322, 6934.514583979073, 6977.023216749761, 6981.2669669683955, 7005.019297298484, 6575.0, 6665.933340666726, 6697.7655782047395, 6760.459163266829, 6762.932370676231, 6568.310327415744, 6808.183018037867, 6810.353016463428, 6900.7929762107215, 6910.585364878123, 6824.7952561423235, 6952.756653517103, 7031.437485001085, 7033.7186512540975, 7034.788956331318, 6728.831779205559, 6746.359095885883, 6816.216135144522, 6818.147731533559, 6828.590284582742, 6411.230652321751, 6501.34986501365, 6504.414602685781, 6508.08886755864, 6510.609363438209, 6511.120998665119, 6512.381323774234, 6512.967435162794, 6514.6416947068365, 6526.053722210348, 6566.0, 6621.039949207434, 6621.635810030494, 6671.532992690465, 6757.763478278237, 6563.0, 6594.208694956444, 6620.867582648417, 6624.735010599715, 6631.403173714389], "value": 6266.64329584534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.6849144587887, 837.991620083799, 863.0937515608609, 885.5350940756106, 888.5823662878449, 39824.0, 40729.0, 40842.79578602103, 40856.59143408565, 40871.795641021825, 37082.07294817631, 37323.813380933054, 37371.439428408594, 37390.8130459348, 37403.62596374036, 6947.166340039203, 7029.156501219861, 7039.54242974205, 7042.0, 7045.0, 6913.827154321132, 6988.196357418911, 6991.685374158175, 6995.930040699604, 6999.615021173833, 6980.092587963558, 7605.239476052406, 7795.298423141944, 7802.453828232026, 7803.687852485894, 7678.69285228593, 7698.384129269673, 7702.191269916634, 7704.306612404883, 7708.267714567107, 7503.887441688379, 7562.357199638037, 7648.885266721004, 7655.464117511777, 7679.654415551314, 37527.24945501102, 37746.0, 37934.43098353527, 37977.430338544946, 37984.24031519354, 3433.5536380270655, 3509.6841284284283, 3518.4546395308766, 3530.6645868642436, 3539.256756081226, 30782.692173078205, 31055.84472077625, 31058.689413105807, 31088.533671994937, 31094.0, 5177.896442071137, 5188.040212560688, 5190.091733946582, 5215.217717342391, 5215.895682086337, 176411.0, 179269.0, 182581.0, 183805.0, 198021.0, 47304.763476183085, 47678.28482572764, 47686.0, 47758.656894017084, 47826.28260576094, 50019.24971125436, 50119.49880501221, 50148.24777628339, 50172.24741628879, 50188.49811501838, 15466.0, 15546.067235965653, 15569.0, 15585.454509092127, 15776.13231272291, 12890.162139461092, 12894.613161605166, 12902.67743306425, 12927.353632318347, 12930.547430839875, 13941.163530188222, 14132.929335353258, 14158.50445234412, 14196.14823110596, 14265.57203283903, 5860.443257890493, 5924.081767326072, 5971.5222782177325, 5972.431854302691, 5981.192539007178, 1020.6121673764071, 1033.075397519216, 1034.9948250258851, 1039.8544203811473, 1049.239301506417, 22738.20416285422, 22891.542169156524, 22901.19845805389, 22971.358293796427, 22987.425314367276, 1104.8066588347167, 1121.9270747401392, 1130.1687280120398, 1134.4271143072694, 1134.6655774939652, 11884.702882428008, 12189.84196501331, 12218.755624887452, 12236.021118310513, 12287.262764234174, 217697.0, 220154.0, 220669.0, 220703.0, 221069.0, 51942.0, 51962.22056669153, 52001.7399912998, 52109.218361724605, 52226.73886630542, 1439.3235179465635, 1464.3410465290663, 1471.6762312291278, 1474.0492382413283, 1476.1364601708121, 22321.77678223262, 22734.317970460914, 22839.885800571556, 22885.08459661595, 23154.652680209474, 37329.25341493209, 37338.6266137346, 37412.625873740915, 37453.4381984265, 37594.24811503809, 195029.0, 195800.0, 196073.0, 196208.0, 196227.0, 29619.111426657233, 30115.54826677558, 32430.0, 33453.0, 33585.0, 40858.38712419375, 42304.78847605742, 42831.57168428276, 43066.56933430626, 43432.565674342855, 31207.84396078005, 31209.531857022615, 31348.0, 31618.683813162494, 31748.523772143897, 31118.84440577873, 31142.0, 31470.055898323088, 31510.684893150774, 31888.202794930312, 35297.823510882285, 35301.646983529834, 35330.47004294989, 35451.468227977115, 38217.426738598384, 32830.0, 32842.343153137284, 32934.83532582322, 33155.668443315255, 33336.33327333391, 23800.761992380547, 23846.284611461684, 24579.03570414697, 24637.507249854545, 24656.753432466165], "value": 16893.990120578568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3713004305134, 558.6396774080717, 570.3355590736792, 588.1501230721608, 592.2715060475615, 22166.778332216672, 22467.662985055238, 23050.423739406524, 23070.538589228225, 23082.192123275647, 26582.468350632975, 27090.0, 27203.591946120825, 27210.45579088417, 27230.45539089217, 7154.463415243851, 7321.670524826369, 7337.88993165103, 7353.52202106864, 7356.74251401201, 6828.419584335337, 7125.073740413739, 7200.675969581355, 7216.8917466238045, 7291.161516425599, 7126.572405655677, 7147.535410198347, 7148.642567871611, 7149.53528020677, 7150.10623672041, 7135.322144396274, 7142.642867856613, 7145.571265724073, 7154.892676609855, 7166.749163779295, 7016.36852683261, 7019.5086343955945, 7025.332593403618, 7035.92964070363, 7037.296270372973, 30319.0, 30766.846165769253, 31506.0, 31598.842005790055, 31731.365372692417, 2080.916763329465, 2109.694094356325, 2110.5884352551257, 2115.4394085567337, 2116.67191585303, 20607.175712971464, 21193.258235961668, 21201.363959081253, 21214.681779773317, 21244.0, 2517.7230504644476, 2564.230730780758, 2661.38788078743, 2665.520206362854, 2678.517866783978, 126851.0, 131602.99999999904, 131782.3410882949, 132061.33969330092, 132248.0, 19761.505962351057, 20809.0, 20858.582828343348, 21436.78563214379, 22159.0, 21750.89124554367, 23089.76910230876, 23175.0, 23178.884105579364, 42036.36945445821, 10094.394336339843, 10156.542955567018, 10297.433641149659, 10431.94784026075, 10534.20993425496, 9519.190868776093, 9534.809303813885, 9604.66383676568, 9649.758756031155, 9743.561539730728, 9221.907780922105, 9222.170004699476, 9271.90728092724, 9360.0, 9469.90530094704, 2673.278214881971, 2683.825551339157, 2808.8314701117997, 2823.491771481153, 2845.9573106403423, 890.8663700444855, 937.95310234488, 957.8563215517589, 958.5878072428783, 963.0995019656643, 19031.333903313596, 19381.612367752565, 19431.611367772566, 19474.8052519473, 19709.901450492656, 992.9106380425796, 1025.9435731034864, 1027.3784360461962, 1030.258214085857, 1031.1544533482472, 10434.895651043544, 10870.728231794268, 10882.945585272022, 10998.670039898816, 11005.724856878482, 490828.0, 493567.0, 505849.0, 509201.0, 510070.0, 114012.0, 116708.0, 117702.0, 118533.0, 118806.0, 1141.1384404774508, 1155.8035134027236, 1180.1974657232993, 1180.893719565226, 1180.9114316426303, 17157.57106072358, 17231.0, 17442.127893605524, 17743.556411089827, 17832.3758668446, 53411.732941335045, 54359.72820135874, 54744.45255547394, 54800.45199547953, 55866.72066639803, 70199.64900175671, 72262.63868680623, 74037.6298118506, 74214.62892685502, 75039.62480187565, 13904.51334203298, 14217.573472795833, 14302.141871487744, 14319.570412887213, 14352.425902963765, 22148.88925555362, 22231.777252251282, 22263.109475620793, 22314.330570082922, 22430.102795888633, 17629.647407051532, 17773.911130444267, 17824.287028518713, 18065.09674516295, 18200.99894505815, 15670.608234794221, 16046.197690115681, 16513.0, 16524.504264872074, 16604.58488537796, 18358.0, 18360.265589376275, 18617.162227699515, 18677.252909883453, 19668.21327146898, 14615.123092614476, 14777.113373197213, 14781.260936952895, 14841.332140053508, 14875.330610122353, 17190.742138868176, 17677.558061048578, 18766.906165469085, 18802.623947521246, 18915.0], "value": 12357.203573756145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.8315210598676, 1377.2562816079317, 1403.4736973634888, 1409.880160186384, 1416.5325442603948, 15112.244387780609, 15305.540833775005, 15666.0, 15781.0, 15800.60498487537, 15808.367665293403, 15924.203789810492, 15937.282822272997, 16034.59913502163, 16079.758803617926, 2736.192823117185, 2767.8892844286306, 2772.279207406079, 2775.3755405033808, 2798.1885253276523, 2651.973480265192, 2660.5477068898235, 2734.9589756153673, 2741.1091395296608, 2748.477789220042, 2743.1633351827686, 2789.888404463819, 2792.8184667996616, 2809.1291699573094, 2809.887604495818, 2655.150351887397, 2687.543117670001, 2697.460507898428, 2698.9595156072673, 2700.621912932191, 2668.6931002934716, 2673.585594232897, 2698.37937274428, 2698.6221928929967, 2699.2172270041665, 14893.925530372388, 15272.618184545365, 15273.159976201305, 15290.541283761506, 15378.692426151414, 7936.246056624612, 8226.300764435031, 8247.546384948826, 8251.092379838214, 8256.339492840558, 5278.973605131988, 5295.602829787743, 5554.1391084381985, 5663.377028526858, 5666.263385759866, 1860.7022876339856, 1886.9056547172725, 1916.5400303927097, 1946.9221231150736, 1953.736245606839, 26902.865485672643, 26993.460130797273, 27201.0, 27270.45459090827, 27276.181714548595, 6824.727010919508, 6841.17905851301, 6883.793486195422, 6963.4777391695825, 7051.823704407431, 17661.29354825818, 17664.381746638806, 17665.38171164003, 17682.0, 17693.823061769475, 7885.1326354101, 8169.346452283803, 8366.790830229293, 8402.663893444194, 8421.915780842113, 7423.777286681408, 7440.404767618686, 7473.4021278297605, 7475.289847464483, 7521.887171692429, 5000.149914548672, 5128.461511541309, 5157.948420515747, 5186.5332120108615, 5193.506616871467, 1317.4005827348533, 1319.729455461628, 1442.9855701443062, 1448.739226939161, 1453.7237924794256, 896.7578753736585, 922.1055576091181, 925.6251218256617, 927.5918595817818, 939.6992962252014, 8197.34421246299, 8496.745097647081, 8512.957435212908, 8517.829643407222, 8534.061253262136, 993.8906720260766, 1013.083159740436, 1018.495844556949, 1028.2339656955467, 1028.8096702110133, 5067.1639179535705, 5103.157978933508, 5118.078745825713, 5143.588512918957, 5224.346956630421, 21840.45398865041, 22490.887545562495, 22502.549949000928, 22701.65947510789, 22896.65655015176, 20646.380608581767, 21943.780562194494, 22267.220647277267, 22407.0, 22423.21518746836, 11267.436628168558, 11613.187076904704, 11655.18413711032, 11739.002184814215, 11744.17790754639, 8434.493930364199, 8583.613737381958, 8733.170348816851, 8819.867701984347, 9003.414778039407, 18233.544161396072, 18474.907625461787, 18639.440816775517, 18860.24559017624, 19231.0, 19251.22995080181, 19316.130774114918, 19386.90306548458, 19537.804621953597, 19591.118399672334, 11370.374629395463, 11448.198626096426, 11496.770064598828, 11595.5941542049, 11600.709982250512, 13425.0, 13590.116642418212, 13611.931940340632, 13615.387307570985, 13619.31903404806, 11201.60794372193, 11208.439578021229, 11270.94364528172, 11339.262947908359, 11485.655430337103, 10907.618233361794, 11029.83455248188, 11066.28069175501, 11185.776284474428, 11292.943535282271, 9440.95279523598, 9623.56693948788, 9633.421994680342, 9638.325317228007, 9657.0, 7338.633068346669, 7398.038255026812, 7464.216257293123, 7483.738069167553, 7488.775336739906, 7368.963155184189, 7456.627168641655, 7477.92522074794, 7565.735199268, 7581.279778421042], "value": 6763.856437670916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.745187832571, 504.30657845462514, 525.1597444089457, 525.9815906443271, 535.3361831329153, 6261.248650161976, 6301.6534090625, 6357.23713154421, 6368.7452501899925, 6469.935300646992, 6141.662208578527, 6143.2628084629905, 6183.350748171445, 6287.811365659026, 6297.2128483939505, 5025.84922452327, 5054.873628159307, 5067.391912970449, 5072.3405957225605, 5108.438071812097, 4896.77964491597, 4999.500049994989, 5009.198528235483, 5100.1074811907765, 5101.438841727407, 4925.581325587312, 4964.726940018298, 5005.1491246488, 5035.974820125894, 5059.2916991621205, 4966.453690094087, 4996.500349965011, 5012.949870501303, 5037.722925239111, 5086.237064440364, 4448.866534003985, 4490.169318676056, 4526.366308716782, 4528.977355113237, 4531.456225252958, 6226.719797609118, 6230.844228894314, 6287.8742425151695, 6289.8742025159245, 6311.810645680637, 5740.56945729072, 5757.136429535562, 5759.971200144015, 5767.279090113736, 5855.180274761537, 6666.233383160901, 6708.362705542965, 6719.697613607351, 6725.899111513331, 6743.629100399476, 4883.731394773286, 4894.583960363373, 4897.436794768611, 4925.3597032385915, 4926.679765815211, 7087.929120708778, 7093.3970612498, 7132.393746531551, 7158.821029474305, 7172.103487064117, 5027.4721154279005, 5067.163917953497, 5075.893504195791, 5077.771500282496, 5095.923561146586, 5089.491050894955, 5142.1772516397195, 5152.742362881841, 5179.326687530673, 5201.609879259071, 5797.507211886952, 5827.562932780059, 5854.2096816930025, 5875.441833025856, 5877.706114694333, 6594.823708176386, 6631.33686631333, 6649.60102393858, 6726.932730672631, 6849.732799432121, 1656.3954156732946, 1700.5663555793194, 1719.6474722681821, 1774.7160454327504, 1775.6715007723612, 1210.939453027345, 1215.1251099208555, 1226.4174517104304, 1239.1759479945915, 1245.5578269714301, 5770.798022069207, 5791.5656325775735, 5872.324682661549, 5894.351621321651, 5916.615419997686, 6720.831979200461, 6742.561733487406, 6765.898511522331, 6885.896711549331, 6925.6190909500465, 5837.22731702438, 5921.496672782861, 5921.795525177086, 5974.2830860297045, 5983.401659833982, 3569.1255642367787, 3645.9582633724667, 3650.1604630935035, 3684.373656478405, 3696.0205545530457, 6590.538662293593, 6682.465402767767, 6690.220025685472, 6709.396154346132, 6744.494162937799, 7028.856198859397, 7052.224255331909, 7073.823154421078, 7162.994361578766, 7201.207867134611, 6558.311377305409, 6632.303608121174, 6659.933400665931, 6663.766768163091, 6727.461803055744, 6762.8647427052165, 6825.897611535732, 6856.862862742618, 6872.0, 6926.0, 6783.152105986752, 6794.898076528757, 6804.081449004321, 6859.176898772179, 6936.930630693831, 6642.701078451385, 6657.434118099822, 6690.397864192246, 6703.787750042572, 6722.6638668065425, 5524.259858144672, 5547.972260138835, 5563.916541251803, 5591.161325801162, 5615.241942337732, 6587.934120658732, 6792.93207067923, 6830.248672646105, 6858.794236172923, 6930.0, 6280.0, 6614.206295244601, 6637.668116594247, 6648.767293144717, 6652.966735166293, 6631.0, 6646.7341306349135, 6659.167604049494, 6679.9332006679315, 6708.19501659804, 6571.704273307617, 6598.406143447113, 6599.208095028627, 6628.734850605922, 6641.535092543476, 6560.770373037111, 6636.568623039487, 6659.801235777607, 6679.56582822115, 6733.764318248838, 6392.712327945161, 6433.260175079926, 6498.870022599616, 6510.902336465051, 6543.934560654333], "value": 5154.532151104994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.5581836990691, 904.8506996345603, 913.9954300228497, 914.2594498456247, 917.756794449471, 18682.34611788586, 19549.0, 19641.0, 19651.705224421647, 21738.3478495645, 20442.2845200418, 21733.45666358342, 21836.8908155459, 21986.45033874154, 22025.118995240213, 957.3585697582619, 979.485769970764, 982.2878413150445, 983.2772911909741, 983.6458874805064, 941.6186444489958, 983.9311248212628, 986.842105263158, 987.7728122531786, 987.9456629885353, 1027.5581499955017, 1042.3381152967845, 1042.5517027678095, 1043.9739006524821, 1044.7597052677888, 1040.9115225205828, 1041.448032542746, 1041.781225942553, 1041.8489319048733, 1042.1975079189058, 769.7113582406597, 771.2210667226086, 771.4252881603186, 771.9073711154641, 772.0966469230957, 17795.377161799406, 18022.36921707734, 18210.817891821178, 18215.726764098417, 19576.02119894014, 20040.1983920643, 20057.598848023103, 20514.076866541043, 20523.384298471068, 20562.897185514128, 16256.51230463088, 16338.75491867623, 16412.343506259735, 16505.422310219205, 16560.917195414066, 3688.0, 3705.4256590228556, 3707.9814600927093, 3714.7771133732062, 3726.441033844918, 117877.41061294639, 118627.40686296599, 118870.0, 119818.40090799578, 121569.39215303956, 16435.424760133577, 16947.983121012778, 16979.83020169807, 17010.914945425193, 17030.233639486254, 29061.709382906323, 30434.69565304363, 30792.538111928337, 30802.229944251125, 30833.537496937563, 8703.521306328214, 8995.415298005608, 8998.955005225063, 9046.095390460901, 9098.454092754457, 4479.216137175981, 4536.387587675687, 4569.9314510282375, 4581.610563102107, 4584.77076146198, 5118.411382691038, 5238.2404551340605, 5668.773249070074, 5898.262717160355, 5923.851903702356, 1120.2998126171144, 1122.2705241592867, 1145.1125377832248, 1147.1052578988401, 1151.424287856072, 663.4625952978104, 678.0845858091537, 691.5539477037282, 696.0776970514089, 698.3051863395954, 10556.577736890438, 10961.725956850983, 11360.886391136148, 11982.041436685044, 12312.322822244863, 668.7659319238325, 674.7132468700783, 682.7849227493324, 683.7641013850214, 688.6591137387026, 5584.21820945068, 5708.372079071299, 5731.426857314235, 5758.913616295759, 5816.1566572846705, 105760.0, 108867.45566272276, 109101.45449272703, 109713.0, 111723.0, 104924.0, 105011.47494262633, 106180.0, 107971.46014269878, 111091.44454277838, 90961.54519227493, 91718.08281917228, 93038.53480732688, 95033.52483237677, 95058.04941950631, 10198.694039178836, 10362.533685983997, 10362.844557331495, 10530.040971758348, 10761.139108871115, 37638.24723505569, 42119.0, 44106.77946610247, 45229.547704522534, 45506.0, 77311.2268877304, 79609.0, 79894.60052699699, 80429.19570804217, 81086.0, 18024.81975180284, 18501.72247416263, 18563.25746970106, 18586.81413185905, 18864.151113200212, 19976.20095196176, 19985.30051448192, 19989.500262493555, 20018.399448016582, 20131.79868201299, 17538.386156484463, 17748.20133093988, 17828.821711783236, 17866.0, 18021.909890450464, 16697.666046678754, 17055.0, 17097.401590944257, 17130.314787408362, 17266.91366543159, 16508.75236871424, 16579.50261492157, 16661.416850410176, 16770.496885093467, 16809.831901680827, 12193.207441516273, 12271.447784849524, 12426.130170887951, 12582.937085314516, 12681.80977285323, 11987.64037078889, 12095.455704493143, 12115.575954841539, 12122.0, 12306.0], "value": 9129.850775019706, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 115.0, 99.0, 106.0, 107.0, 109.0, 114.0, 98.0, 107.0, 108.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 117.0, 146.0, 171.0, 116.0, 144.0, 151.0, 120.0, 170.0, 117.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 167.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 175.0, 75.0, 74.0, 76.0, 74.0, 170.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 79.0, 79.0, 80.0, 127.0, 79.0, 80.0, 133.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 149.0, 150.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 93.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 52.0, 52.0, 54.0, 55.0, 53.0, 57.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 37.0, 37.0, 42.0, 38.0, 38.0, 37.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 75.0, 76.0, 74.0, 76.0, 75.0, 75.0, 78.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 116.0, 118.0, 123.0, 122.0, 121.0, 120.0, 117.0, 118.0, 161.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 167.0, 176.0, 177.0, 171.0, 170.0, 174.0, 179.0, 173.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 67.0, 63.0, 63.0, 65.0, 70.0, 62.0, 63.0], "value": 64.8, "unit": "score"}]}]} 02:39:14 INFO - Return code: 0 02:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:14 INFO - # TBPL SUCCESS # 02:39:14 INFO - Running post-action listener: _package_coverage_data 02:39:14 INFO - Running post-action listener: _resource_record_post_action 02:39:14 INFO - [mozharness: 2017-09-01 09:39:14.906186Z] Finished run-tests step (success) 02:39:14 INFO - Running post-run listener: _resource_record_post_run 02:39:14 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391065600; Read time: 248; Write time: 297324 02:39:14 INFO - TinderboxPrint: CPU usage
13.1% 02:39:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 248 02:39:14 INFO - TinderboxPrint: I/O write bytes / time
391,065,600 / 297,324 02:39:14 INFO - TinderboxPrint: CPU idle
8,243.5 (86.9%) 02:39:14 INFO - TinderboxPrint: CPU user
1,192.4 (12.6%) 02:39:14 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108462080; Read time: 76; Write time: 91008 02:39:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:39:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282603520; Read time: 172; Write time: 206316 02:39:15 INFO - Running post-run listener: _upload_blobber_files 02:39:15 INFO - Blob upload gear active. 02:39:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:15 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 02:39:15 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'] 02:39:15 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 02:39:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:17 INFO - (blobuploader) - INFO - Done attempting. 02:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:17 INFO - (blobuploader) - INFO - Done attempting. 02:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:21 INFO - (blobuploader) - INFO - Done attempting. 02:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:22 INFO - (blobuploader) - INFO - Done attempting. 02:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:22 INFO - Return code: 0 02:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33c8cc98fe8f6e29ebb28b92c87f52e194f49c44b48cda81c7d9b071a4964cb1cd1aaa22de9a81bce693596bfcb70b2e2aaf39e1a16b35ec6f4605b0aa94e426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e86ea64b9a553a69b89113dc78b74afeed193ca10d0f11adf78febb84ef7f6d14bb2b9dfdeb69e5bb595f3483825d578f54f2c24e73804a6611406aa08ec8e6f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9874970eee3e6c352cd520a100cf931f8b353eb4df112e9f29e733a5b18e138b935ff518410324e0533ef6e5bc4f7300c22e12cb306b1f15c0494e9d299f870", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad722d04c8a688b8ad83c3b761118f64cfa5313caec8f9a936c6d742c156d2f5a147356a1799b544aa07392568af9a6be1edd665820c14fda87c22243085a88"} 02:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:22 INFO - Contents: 02:39:22 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33c8cc98fe8f6e29ebb28b92c87f52e194f49c44b48cda81c7d9b071a4964cb1cd1aaa22de9a81bce693596bfcb70b2e2aaf39e1a16b35ec6f4605b0aa94e426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e86ea64b9a553a69b89113dc78b74afeed193ca10d0f11adf78febb84ef7f6d14bb2b9dfdeb69e5bb595f3483825d578f54f2c24e73804a6611406aa08ec8e6f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9874970eee3e6c352cd520a100cf931f8b353eb4df112e9f29e733a5b18e138b935ff518410324e0533ef6e5bc4f7300c22e12cb306b1f15c0494e9d299f870", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad722d04c8a688b8ad83c3b761118f64cfa5313caec8f9a936c6d742c156d2f5a147356a1799b544aa07392568af9a6be1edd665820c14fda87c22243085a88"} 02:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:22 INFO - Copying logs to upload dir... 02:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.006351 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-09-01 02:39:22.448614) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:22.456284) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33c8cc98fe8f6e29ebb28b92c87f52e194f49c44b48cda81c7d9b071a4964cb1cd1aaa22de9a81bce693596bfcb70b2e2aaf39e1a16b35ec6f4605b0aa94e426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e86ea64b9a553a69b89113dc78b74afeed193ca10d0f11adf78febb84ef7f6d14bb2b9dfdeb69e5bb595f3483825d578f54f2c24e73804a6611406aa08ec8e6f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9874970eee3e6c352cd520a100cf931f8b353eb4df112e9f29e733a5b18e138b935ff518410324e0533ef6e5bc4f7300c22e12cb306b1f15c0494e9d299f870", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad722d04c8a688b8ad83c3b761118f64cfa5313caec8f9a936c6d742c156d2f5a147356a1799b544aa07392568af9a6be1edd665820c14fda87c22243085a88"} build_url:https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/EVBwkXv4QIqaI8RoA8-sCA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/33c8cc98fe8f6e29ebb28b92c87f52e194f49c44b48cda81c7d9b071a4964cb1cd1aaa22de9a81bce693596bfcb70b2e2aaf39e1a16b35ec6f4605b0aa94e426", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e86ea64b9a553a69b89113dc78b74afeed193ca10d0f11adf78febb84ef7f6d14bb2b9dfdeb69e5bb595f3483825d578f54f2c24e73804a6611406aa08ec8e6f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9874970eee3e6c352cd520a100cf931f8b353eb4df112e9f29e733a5b18e138b935ff518410324e0533ef6e5bc4f7300c22e12cb306b1f15c0494e9d299f870", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fad722d04c8a688b8ad83c3b761118f64cfa5313caec8f9a936c6d742c156d2f5a147356a1799b544aa07392568af9a6be1edd665820c14fda87c22243085a88"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:22.486011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:22.486398) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1504243620.325096-1945387036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 02:39:22.569375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:22.569702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 02:39:22.570026) ========= ========= Total master_lag: 0.26 =========