builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-075 starttime: 1507071963.34 results: success (0) revision: c97190c389c4cfef20fe55b4bacade95a36ae6ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.338334) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.339075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.339343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.422817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.423153) ========= 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-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 16:06:03-- 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% 75.2M=0s 2017-10-03 16:06:03 (75.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.214532 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.671712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.672020) ========= 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-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014658 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:03.737707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-03 16:06:03.738026) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c97190c389c4cfef20fe55b4bacade95a36ae6ef --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 c97190c389c4cfef20fe55b4bacade95a36ae6ef --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-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 16:06:03,790 truncating revision to first 12 chars 2017-10-03 16:06:03,790 Setting DEBUG logging. 2017-10-03 16:06:03,790 attempt 1/10 2017-10-03 16:06:03,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c97190c389c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 16:06:04,863 unpacking tar archive at: mozilla-central-c97190c389c4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.800543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-03 16:06:06.557824) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:06.558154) ========= script_repo_revision: c97190c389c4cfef20fe55b4bacade95a36ae6ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:06.558526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:06.558792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 16:06:06.571335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-10-03 16:06:06.571605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:06 INFO - MultiFileLogger online at 20171003 16:06:06 in /builds/slave/test 16:06:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:06:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:06 INFO - {'append_to_log': False, 16:06:06 INFO - 'base_work_dir': '/builds/slave/test', 16:06:06 INFO - 'blob_upload_branch': 'Firefox', 16:06:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:06 INFO - 'branch': 'Firefox', 16:06:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:06 INFO - 'code_coverage': False, 16:06:06 INFO - 'config_files': ('talos/linux_config.py',), 16:06:06 INFO - 'default_actions': ('clobber', 16:06:06 INFO - 'read-buildbot-config', 16:06:06 INFO - 'download-and-extract', 16:06:06 INFO - 'populate-webroot', 16:06:06 INFO - 'create-virtualenv', 16:06:06 INFO - 'install', 16:06:06 INFO - 'setup-mitmproxy', 16:06:06 INFO - 'run-tests'), 16:06:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:06 INFO - 'disable_ccov_upload': False, 16:06:06 INFO - 'disable_stylo': False, 16:06:06 INFO - 'download_minidump_stackwalk': True, 16:06:06 INFO - 'download_symbols': 'ondemand', 16:06:06 INFO - 'enable_stylo': False, 16:06:06 INFO - 'enable_webrender': False, 16:06:06 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:06:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:06 INFO - 'gecko_profile': False, 16:06:06 INFO - 'gecko_profile_interval': 0, 16:06:06 INFO - 'installer_path': 'installer.exe', 16:06:06 INFO - 'log_level': 'info', 16:06:06 INFO - 'log_name': 'talos', 16:06:06 INFO - 'log_to_console': True, 16:06:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:06 INFO - 'opt_config_files': (), 16:06:06 INFO - 'pip_index': False, 16:06:06 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:06:06 INFO - 'system_bits': '32', 16:06:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:06 INFO - 'title': 'talos-linux64-ix-075', 16:06:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:06 INFO - 'use_talos_json': True, 16:06:06 INFO - 'verify': 'False', 16:06:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:06 INFO - 'work_dir': 'build'} 16:06:06 INFO - [mozharness: 2017-10-03 23:06:06.857299Z] Running clobber step. 16:06:06 INFO - Running pre-action listener: _resource_record_pre_action 16:06:06 INFO - Running main action method: clobber 16:06:06 INFO - rmtree: /builds/slave/test/build 16:06:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:07 INFO - Running post-action listener: _resource_record_post_action 16:06:07 INFO - [mozharness: 2017-10-03 23:06:07.831127Z] Finished clobber step (success) 16:06:07 INFO - [mozharness: 2017-10-03 23:06:07.831226Z] Running read-buildbot-config step. 16:06:07 INFO - Running pre-action listener: _resource_record_pre_action 16:06:07 INFO - Running main action method: read_buildbot_config 16:06:07 INFO - Using buildbot properties: 16:06:07 INFO - { 16:06:07 INFO - "project": "", 16:06:07 INFO - "product": "firefox", 16:06:07 INFO - "who": "kwierso@gmail.com", 16:06:07 INFO - "installer_path": "public/build/target.tar.bz2", 16:06:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:06:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:06:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:06:07 INFO - "stage_platform": "linux64-pgo", 16:06:07 INFO - "basedir": "/builds/slave/test", 16:06:07 INFO - "buildnumber": 14, 16:06:07 INFO - "platform": "ubuntu64_hw", 16:06:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:06:07 INFO - "slavebuilddir": "test", 16:06:07 INFO - "taskId": "df7OY6gpTF649GTyjwJO5w", 16:06:07 INFO - "branch": "mozilla-central", 16:06:07 INFO - "script_repo_revision": "production", 16:06:07 INFO - "revision": "c97190c389c4cfef20fe55b4bacade95a36ae6ef", 16:06:07 INFO - "slavename": "talos-linux64-ix-075", 16:06:07 INFO - "repo_path": "mozilla-central" 16:06:07 INFO - } 16:06:07 INFO - Finding installer, test and symbols from parent task. 16:06:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/df7OY6gpTF649GTyjwJO5w'}, attempt #1 16:06:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/df7OY6gpTF649GTyjwJO5w'}, attempt #1 16:06:08 INFO - Task dependencies: Ffxf4E-mT86Y4EN0dsL5BA 16:06:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA'}, attempt #1 16:06:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 16:06:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.test_packages.json 16:06:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.crashreporter-symbols.zip 16:06:09 INFO - Running post-action listener: _resource_record_post_action 16:06:09 INFO - [mozharness: 2017-10-03 23:06:09.424747Z] Finished read-buildbot-config step (success) 16:06:09 INFO - [mozharness: 2017-10-03 23:06:09.424968Z] Running download-and-extract step. 16:06:09 INFO - Running pre-action listener: _resource_record_pre_action 16:06:09 INFO - Running main action method: download_and_extract 16:06:09 INFO - mkdir: /builds/slave/test/build/tests 16:06: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')]} 16:06:09 INFO - trying https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.test_packages.json 16:06:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:06:10 INFO - Downloaded 989 bytes. 16:06:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:06:10 INFO - Using the following test package requirements: 16:06:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:06:10 INFO - u'common': [u'target.common.tests.zip'], 16:06:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:06:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:06:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:06:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:06:10 INFO - u'mozbase': [u'target.common.tests.zip'], 16:06:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:06:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:06:10 INFO - u'web-platform': [u'target.common.tests.zip', 16:06:10 INFO - u'target.web-platform.tests.tar.gz'], 16:06:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:06:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:06:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.common.tests.zip 16:06:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:06:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.common.tests.zip into memory 16:06:11 INFO - Content-Length response header: 55878624 16:06:11 INFO - Bytes received: 55878624 16:06:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.talos.tests.zip 16:06:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:06:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.talos.tests.zip into memory 16:06:24 INFO - Content-Length response header: 14533844 16:06:24 INFO - Bytes received: 14533844 16:06: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')]} 16:06:24 INFO - trying https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 16:06:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:06:27 INFO - Downloaded 62422288 bytes. 16:06:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 16:06:27 INFO - mkdir: /builds/slave/test/properties 16:06:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:06:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:06:27 INFO - Contents: 16:06:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - Running post-action listener: find_tests_for_verification 16:06:27 INFO - Running post-action listener: set_extra_try_arguments 16:06:27 INFO - [mozharness: 2017-10-03 23:06:27.144169Z] Finished download-and-extract step (success) 16:06:27 INFO - [mozharness: 2017-10-03 23:06:27.144399Z] Running populate-webroot step. 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: populate_webroot 16:06:27 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:06:27 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['tresize', 16:06:27 INFO - 'tcanvasmark']}, 16:06:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:06:27 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['dromaeo_css', 16:06:27 INFO - 'kraken']}, 16:06:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:27 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'tests': ['damp', 'tps']}, 16:06:27 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['damp', 'tps']}, 16:06:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:06:27 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['dromaeo_dom']}, 16:06:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:06:27 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['basic_compositor_video', 16:06:27 INFO - 'glvideo']}, 16:06:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:06:27 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['ts_paint_webext', 16:06:27 INFO - 'tp5o_webext']}, 16:06:27 INFO - 'other-e10s': {'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_many_windows', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint', 16:06:27 INFO - 'cpstartup']}, 16:06:27 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['a11yr', 16:06:27 INFO - 'ts_paint', 16:06:27 INFO - 'tpaint', 16:06:27 INFO - 'sessionrestore', 16:06:27 INFO - 'sessionrestore_many_windows', 16:06:27 INFO - 'sessionrestore_no_auto_restore', 16:06:27 INFO - 'tabpaint', 16:06:27 INFO - 'cpstartup']}, 16:06:27 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:06:27 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:06:27 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['perf_reftest_singletons']}, 16:06:27 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['perf_reftest']}, 16:06:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:06:27 INFO - 'tsvgr_opacity', 16:06:27 INFO - 'tart', 16:06:27 INFO - 'tscrollx', 16:06:27 INFO - 'tsvg_static']}, 16:06:27 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['tsvgx', 16:06:27 INFO - 'tsvgr_opacity', 16:06:27 INFO - 'tart', 16:06:27 INFO - 'tscrollx', 16:06:27 INFO - 'tsvg_static']}, 16:06:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:06:27 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-stylo'], 16:06:27 INFO - 'tests': ['tp5o']}, 16:06:27 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:06:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:06:27 INFO - 'talos_options': ['--mitmproxy', 16:06:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:06:27 INFO - '--firstNonBlankPaint'], 16:06:27 INFO - 'tests': ['tp6_google', 16:06:27 INFO - 'tp6_youtube', 16:06:27 INFO - 'tp6_amazon', 16:06:27 INFO - 'tp6_facebook']}, 16:06:27 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:06:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:06:27 INFO - 'talos_options': ['--disable-stylo', 16:06:27 INFO - '--mitmproxy', 16:06:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:06:27 INFO - '--firstNonBlankPaint'], 16:06:27 INFO - 'tests': ['tp6_google', 16:06:27 INFO - 'tp6_youtube', 16:06:27 INFO - 'tp6_amazon', 16:06:27 INFO - 'tp6_facebook']}, 16:06:27 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:06:27 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:06:27 INFO - 'talos_options': ['--stylo-threads=1', 16:06:27 INFO - '--mitmproxy', 16:06:27 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:06:27 INFO - '--firstNonBlankPaint'], 16:06:27 INFO - 'tests': ['tp6_google', 16:06:27 INFO - 'tp6_youtube', 16:06:27 INFO - 'tp6_amazon', 16:06:27 INFO - 'tp6_facebook']}, 16:06:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--xperf_path', 16:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:27 INFO - 'tests': ['tp5n']}, 16:06:27 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:06:27 INFO - 'talos_options': ['--disable-stylo', 16:06:27 INFO - '--xperf_path', 16:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:27 INFO - 'tests': ['tp5n']}}} 16:06:27 INFO - Running post-action listener: _resource_record_post_action 16:06:27 INFO - [mozharness: 2017-10-03 23:06:27.166360Z] Finished populate-webroot step (success) 16:06:27 INFO - [mozharness: 2017-10-03 23:06:27.166451Z] Running create-virtualenv step. 16:06:27 INFO - Running pre-action listener: _resource_record_pre_action 16:06:27 INFO - Running main action method: create_virtualenv 16:06:27 INFO - Creating virtualenv /builds/slave/test/build/venv 16:06:27 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:06:27 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:06:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:06:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:06:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:06:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:28 INFO - Installing pip...............done. 16:06:28 INFO - Return code: 0 16:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:06:28 INFO - Reading from file tmpfile_stdout 16:06:28 INFO - Output received: 16:06:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:06:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:28 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')]} 16:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:28 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')]} 16:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:28 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:28 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 16:06:28 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 16:06:28 INFO - Using env: {'DISPLAY': ':0', 16:06:28 INFO - 'HOME': '/home/cltbld', 16:06:28 INFO - 'LANG': 'en_US.UTF-8', 16:06:28 INFO - 'LANGUAGE': 'en_US:en', 16:06:28 INFO - 'LOGNAME': 'cltbld', 16:06:28 INFO - 'MAIL': '/var/mail/cltbld', 16:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:28 INFO - 'MOZ_NO_REMOTE': '1', 16:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:28 INFO - 'NO_EM_RESTART': '1', 16:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:28 INFO - 'PWD': '/builds/slave/test', 16:06:28 INFO - 'SHELL': '/bin/bash', 16:06:28 INFO - 'SHLVL': '1', 16:06:28 INFO - 'TERM': 'linux', 16:06:28 INFO - 'TMOUT': '86400', 16:06:28 INFO - 'USER': 'cltbld', 16:06:28 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:28 INFO - '_': '/tools/buildbot/bin/python'} 16:06:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:06:30 INFO - Downloading/unpacking pip>=1.5 16:06:30 INFO - Running setup.py egg_info for package pip 16:06:30 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:30 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:30 INFO - Installing collected packages: pip 16:06:30 INFO - Found existing installation: pip 1.1 16:06:30 INFO - Uninstalling pip: 16:06:30 INFO - Successfully uninstalled pip 16:06:30 INFO - Running setup.py install for pip 16:06:30 INFO - warning: no files found matching 'pip/cacert.pem' 16:06:30 INFO - warning: no files found matching '*.html' under directory 'docs' 16:06:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:06:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:06:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:06:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:06:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:06:30 INFO - Successfully installed pip 16:06:30 INFO - Cleaning up... 16:06:30 INFO - Return code: 0 16:06:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:30 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:30 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 16:06:30 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 16:06:30 INFO - Using env: {'DISPLAY': ':0', 16:06:30 INFO - 'HOME': '/home/cltbld', 16:06:30 INFO - 'LANG': 'en_US.UTF-8', 16:06:30 INFO - 'LANGUAGE': 'en_US:en', 16:06:30 INFO - 'LOGNAME': 'cltbld', 16:06:30 INFO - 'MAIL': '/var/mail/cltbld', 16:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:30 INFO - 'MOZ_NO_REMOTE': '1', 16:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:30 INFO - 'NO_EM_RESTART': '1', 16:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:30 INFO - 'PWD': '/builds/slave/test', 16:06:30 INFO - 'SHELL': '/bin/bash', 16:06:30 INFO - 'SHLVL': '1', 16:06:30 INFO - 'TERM': 'linux', 16:06:30 INFO - 'TMOUT': '86400', 16:06:30 INFO - 'USER': 'cltbld', 16:06:30 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:30 INFO - '_': '/tools/buildbot/bin/python'} 16:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:30 INFO - Downloading/unpacking psutil>=3.1.1 16:06:30 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 16:06:30 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 16:06:30 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 16:06:30 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 16:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:32 INFO - Installing collected packages: psutil 16:06:32 INFO - Running setup.py install for psutil 16:06:32 INFO - building 'psutil._psutil_linux' extension 16:06:32 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 16:06:32 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 16:06:33 INFO - building 'psutil._psutil_posix' extension 16:06:33 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 16:06:33 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 16:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:33 INFO - Successfully installed psutil 16:06:33 INFO - Cleaning up... 16:06:33 INFO - Return code: 0 16:06:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:06:33 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')]} 16:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:33 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')]} 16:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:33 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:33 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 16:06:33 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 16:06:33 INFO - Using env: {'DISPLAY': ':0', 16:06:33 INFO - 'HOME': '/home/cltbld', 16:06:33 INFO - 'LANG': 'en_US.UTF-8', 16:06:33 INFO - 'LANGUAGE': 'en_US:en', 16:06:33 INFO - 'LOGNAME': 'cltbld', 16:06:33 INFO - 'MAIL': '/var/mail/cltbld', 16:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:33 INFO - 'MOZ_NO_REMOTE': '1', 16:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:33 INFO - 'NO_EM_RESTART': '1', 16:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:33 INFO - 'PWD': '/builds/slave/test', 16:06:33 INFO - 'SHELL': '/bin/bash', 16:06:33 INFO - 'SHLVL': '1', 16:06:33 INFO - 'TERM': 'linux', 16:06:33 INFO - 'TMOUT': '86400', 16:06:33 INFO - 'USER': 'cltbld', 16:06:33 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:33 INFO - '_': '/tools/buildbot/bin/python'} 16:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:06:33 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 16:06:33 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 16:06:33 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 16:06:33 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 16:06:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:06:34 INFO - Installing collected packages: mozsystemmonitor 16:06:34 INFO - Running setup.py install for mozsystemmonitor 16:06:34 INFO - Successfully installed mozsystemmonitor 16:06:34 INFO - Cleaning up... 16:06:34 INFO - Return code: 0 16:06:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:06:34 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')]} 16:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:34 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')]} 16:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:34 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:34 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 16:06:34 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 16:06:34 INFO - Using env: {'DISPLAY': ':0', 16:06:34 INFO - 'HOME': '/home/cltbld', 16:06:34 INFO - 'LANG': 'en_US.UTF-8', 16:06:34 INFO - 'LANGUAGE': 'en_US:en', 16:06:34 INFO - 'LOGNAME': 'cltbld', 16:06:34 INFO - 'MAIL': '/var/mail/cltbld', 16:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:34 INFO - 'MOZ_NO_REMOTE': '1', 16:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:34 INFO - 'NO_EM_RESTART': '1', 16:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:34 INFO - 'PWD': '/builds/slave/test', 16:06:34 INFO - 'SHELL': '/bin/bash', 16:06:34 INFO - 'SHLVL': '1', 16:06:34 INFO - 'TERM': 'linux', 16:06:34 INFO - 'TMOUT': '86400', 16:06:34 INFO - 'USER': 'cltbld', 16:06:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:34 INFO - '_': '/tools/buildbot/bin/python'} 16:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:06:35 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 16:06:35 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 16:06:35 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 16:06:35 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 16:06:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:06:36 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 16:06:36 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 16:06:36 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 16:06:36 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 16:06:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:36 INFO - warning: no files found matching '*.txt' 16:06:36 INFO - no previously-included directories found matching 'build' 16:06:36 INFO - no previously-included directories found matching 'dist' 16:06:36 INFO - no previously-included directories found matching '.git*' 16:06:36 INFO - Installing collected packages: jsonschema, functools32 16:06:36 INFO - Running setup.py install for functools32 16:06:36 INFO - warning: no files found matching '*.txt' 16:06:36 INFO - no previously-included directories found matching 'build' 16:06:36 INFO - no previously-included directories found matching 'dist' 16:06:36 INFO - no previously-included directories found matching '.git*' 16:06:36 INFO - Successfully installed jsonschema functools32 16:06:36 INFO - Cleaning up... 16:06:36 INFO - Return code: 0 16:06:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:36 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:36 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 16:06:36 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 16:06:36 INFO - Using env: {'DISPLAY': ':0', 16:06:36 INFO - 'HOME': '/home/cltbld', 16:06:36 INFO - 'LANG': 'en_US.UTF-8', 16:06:36 INFO - 'LANGUAGE': 'en_US:en', 16:06:36 INFO - 'LOGNAME': 'cltbld', 16:06:36 INFO - 'MAIL': '/var/mail/cltbld', 16:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:36 INFO - 'MOZ_NO_REMOTE': '1', 16:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:36 INFO - 'NO_EM_RESTART': '1', 16:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:36 INFO - 'PWD': '/builds/slave/test', 16:06:36 INFO - 'SHELL': '/bin/bash', 16:06:36 INFO - 'SHLVL': '1', 16:06:36 INFO - 'TERM': 'linux', 16:06:36 INFO - 'TMOUT': '86400', 16:06:36 INFO - 'USER': 'cltbld', 16:06:36 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:36 INFO - '_': '/tools/buildbot/bin/python'} 16:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:06:36 INFO - Cleaning up... 16:06:36 INFO - Return code: 0 16:06:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:36 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:36 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 16:06:36 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 16:06:36 INFO - Using env: {'DISPLAY': ':0', 16:06:36 INFO - 'HOME': '/home/cltbld', 16:06:36 INFO - 'LANG': 'en_US.UTF-8', 16:06:36 INFO - 'LANGUAGE': 'en_US:en', 16:06:36 INFO - 'LOGNAME': 'cltbld', 16:06:36 INFO - 'MAIL': '/var/mail/cltbld', 16:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:36 INFO - 'MOZ_NO_REMOTE': '1', 16:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:36 INFO - 'NO_EM_RESTART': '1', 16:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:36 INFO - 'PWD': '/builds/slave/test', 16:06:36 INFO - 'SHELL': '/bin/bash', 16:06:36 INFO - 'SHLVL': '1', 16:06:36 INFO - 'TERM': 'linux', 16:06:36 INFO - 'TMOUT': '86400', 16:06:36 INFO - 'USER': 'cltbld', 16:06:36 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:36 INFO - '_': '/tools/buildbot/bin/python'} 16:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:06:37 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 16:06:37 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 16:06:37 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 16:06:37 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 16:06:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06:38 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 16:06:38 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 16:06:38 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 16:06:38 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 16:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06:38 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 16:06:38 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 16:06:38 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 16:06:38 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 16:06:38 INFO - Downloading docopt-0.6.1.tar.gz 16:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:38 INFO - Running setup.py install for blobuploader 16:06:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:38 INFO - Running setup.py install for requests 16:06:39 INFO - Running setup.py install for docopt 16:06:39 INFO - Successfully installed blobuploader requests docopt 16:06:39 INFO - Cleaning up... 16:06:39 INFO - Return code: 0 16:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:39 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:39 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 16:06:39 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 16:06:39 INFO - Using env: {'DISPLAY': ':0', 16:06:39 INFO - 'HOME': '/home/cltbld', 16:06:39 INFO - 'LANG': 'en_US.UTF-8', 16:06:39 INFO - 'LANGUAGE': 'en_US:en', 16:06:39 INFO - 'LOGNAME': 'cltbld', 16:06:39 INFO - 'MAIL': '/var/mail/cltbld', 16:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:39 INFO - 'MOZ_NO_REMOTE': '1', 16:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:39 INFO - 'NO_EM_RESTART': '1', 16:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:39 INFO - 'PWD': '/builds/slave/test', 16:06:39 INFO - 'SHELL': '/bin/bash', 16:06:39 INFO - 'SHLVL': '1', 16:06:39 INFO - 'TERM': 'linux', 16:06:39 INFO - 'TMOUT': '86400', 16:06:39 INFO - 'USER': 'cltbld', 16:06:39 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:39 INFO - '_': '/tools/buildbot/bin/python'} 16:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:39 INFO - Running setup.py (path:/tmp/pip-MYQOFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:39 INFO - Running setup.py (path:/tmp/pip-H3sBit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:39 INFO - Running setup.py (path:/tmp/pip-Y15DNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:39 INFO - Running setup.py (path:/tmp/pip-qKTaET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:39 INFO - Running setup.py (path:/tmp/pip-EMKOyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:39 INFO - Running setup.py (path:/tmp/pip-dWKQxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:39 INFO - Running setup.py (path:/tmp/pip-Yd6Fll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:40 INFO - Running setup.py (path:/tmp/pip-XuiOWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:40 INFO - Running setup.py (path:/tmp/pip-zPofjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:40 INFO - Running setup.py (path:/tmp/pip-kibtke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:40 INFO - Running setup.py (path:/tmp/pip-wbTim_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:40 INFO - Running setup.py (path:/tmp/pip-JUz1wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:40 INFO - Running setup.py (path:/tmp/pip-Z0CjeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:40 INFO - Running setup.py (path:/tmp/pip-iOgn18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:40 INFO - Running setup.py (path:/tmp/pip-54BuCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:40 INFO - Running setup.py (path:/tmp/pip-lwMpnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:40 INFO - Running setup.py (path:/tmp/pip-_sxJcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:40 INFO - Running setup.py install for manifestparser 16:06:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:40 INFO - Running setup.py install for mozcrash 16:06:40 INFO - Running setup.py install for mozdebug 16:06:41 INFO - Running setup.py install for mozdevice 16:06:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for mozfile 16:06:41 INFO - Running setup.py install for mozhttpd 16:06:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for mozinfo 16:06:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for mozInstall 16:06:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for mozleak 16:06:41 INFO - Running setup.py install for mozlog 16:06:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for moznetwork 16:06:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:41 INFO - Running setup.py install for mozprocess 16:06:41 INFO - Running setup.py install for mozprofile 16:06:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:42 INFO - Running setup.py install for mozrunner 16:06:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:42 INFO - Running setup.py install for mozscreenshot 16:06:42 INFO - Running setup.py install for moztest 16:06:42 INFO - Running setup.py install for mozversion 16:06:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:42 INFO - Cleaning up... 16:06:42 INFO - Return code: 0 16:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:42 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:42 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 16:06:42 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 16:06:42 INFO - Using env: {'DISPLAY': ':0', 16:06:42 INFO - 'HOME': '/home/cltbld', 16:06:42 INFO - 'LANG': 'en_US.UTF-8', 16:06:42 INFO - 'LANGUAGE': 'en_US:en', 16:06:42 INFO - 'LOGNAME': 'cltbld', 16:06:42 INFO - 'MAIL': '/var/mail/cltbld', 16:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:42 INFO - 'MOZ_NO_REMOTE': '1', 16:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:42 INFO - 'NO_EM_RESTART': '1', 16:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:42 INFO - 'PWD': '/builds/slave/test', 16:06:42 INFO - 'SHELL': '/bin/bash', 16:06:42 INFO - 'SHLVL': '1', 16:06:42 INFO - 'TERM': 'linux', 16:06:42 INFO - 'TMOUT': '86400', 16:06:42 INFO - 'USER': 'cltbld', 16:06:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:42 INFO - '_': '/tools/buildbot/bin/python'} 16:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:42 INFO - Running setup.py (path:/tmp/pip-bNg7eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:42 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)) 16:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:42 INFO - Running setup.py (path:/tmp/pip-cME35I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:42 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)) 16:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:42 INFO - Running setup.py (path:/tmp/pip-b5utg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:42 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)) 16:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:42 INFO - Running setup.py (path:/tmp/pip-w1Fozi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:43 INFO - Running setup.py (path:/tmp/pip-7MY_i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:43 INFO - Running setup.py (path:/tmp/pip-qJIxnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:43 INFO - Running setup.py (path:/tmp/pip-gi2TI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:43 INFO - Running setup.py (path:/tmp/pip-a9MZpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:43 INFO - Running setup.py (path:/tmp/pip-z_s05H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:43 INFO - Running setup.py (path:/tmp/pip-czzsrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:43 INFO - Running setup.py (path:/tmp/pip-Jtr_Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:43 INFO - Running setup.py (path:/tmp/pip-JTHVBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:43 INFO - Running setup.py (path:/tmp/pip-TILIUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:43 INFO - Running setup.py (path:/tmp/pip-HMjr8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:43 INFO - Running setup.py (path:/tmp/pip-Siy8pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:43 INFO - Running setup.py (path:/tmp/pip-2vBhdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:43 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)) 16:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:43 INFO - Running setup.py (path:/tmp/pip-6gUWZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:43 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)) 16:06:43 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)) 16:06:43 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)) 16:06:43 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)) 16:06:43 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)) 16:06:43 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)) 16:06:43 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)) 16:06:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:45 INFO - Downloading blessings-1.6.tar.gz 16:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:45 INFO - Installing collected packages: blessings 16:06:45 INFO - Running setup.py install for blessings 16:06:45 INFO - Successfully installed blessings 16:06:45 INFO - Cleaning up... 16:06:45 INFO - Return code: 0 16:06:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:45 INFO - Reading from file tmpfile_stdout 16:06:45 INFO - Current package versions: 16:06:45 INFO - argparse == 1.2.1 16:06:45 INFO - blessings == 1.6 16:06:45 INFO - blobuploader == 1.2.4 16:06:45 INFO - docopt == 0.6.1 16:06:45 INFO - functools32 == 3.2.3-2 16:06:45 INFO - jsonschema == 2.5.1 16:06:45 INFO - manifestparser == 1.1 16:06:45 INFO - mozInstall == 1.13 16:06:45 INFO - mozcrash == 1.0 16:06:45 INFO - mozdebug == 0.1 16:06:45 INFO - mozdevice == 0.51 16:06:45 INFO - mozfile == 1.2 16:06:45 INFO - mozhttpd == 0.7 16:06:45 INFO - mozinfo == 0.10 16:06:45 INFO - mozleak == 0.1 16:06:45 INFO - mozlog == 3.5 16:06:45 INFO - moznetwork == 0.27 16:06:45 INFO - mozprocess == 0.25 16:06:45 INFO - mozprofile == 0.28 16:06:45 INFO - mozrunner == 6.13 16:06:45 INFO - mozscreenshot == 0.1 16:06:45 INFO - mozsystemmonitor == 0.3 16:06:45 INFO - moztest == 0.8 16:06:45 INFO - mozversion == 1.4 16:06:45 INFO - psutil == 3.1.1 16:06:45 INFO - requests == 1.2.3 16:06:45 INFO - wsgiref == 0.1.2 16:06:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:45 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:45 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 16:06:45 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 16:06:45 INFO - Using env: {'DISPLAY': ':0', 16:06:45 INFO - 'HOME': '/home/cltbld', 16:06:45 INFO - 'LANG': 'en_US.UTF-8', 16:06:45 INFO - 'LANGUAGE': 'en_US:en', 16:06:45 INFO - 'LOGNAME': 'cltbld', 16:06:45 INFO - 'MAIL': '/var/mail/cltbld', 16:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:45 INFO - 'MOZ_NO_REMOTE': '1', 16:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:45 INFO - 'NO_EM_RESTART': '1', 16:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:45 INFO - 'PWD': '/builds/slave/test', 16:06:45 INFO - 'SHELL': '/bin/bash', 16:06:45 INFO - 'SHLVL': '1', 16:06:45 INFO - 'TERM': 'linux', 16:06:45 INFO - 'TMOUT': '86400', 16:06:45 INFO - 'USER': 'cltbld', 16:06:45 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:45 INFO - '_': '/tools/buildbot/bin/python'} 16:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 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)) 16:06:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:06:46 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)) 16:06:46 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)) 16:06:46 INFO - Installing collected packages: simplejson 16:06:46 INFO - Running setup.py install for simplejson 16:06:47 INFO - building 'simplejson._speedups' extension 16:06:47 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 16:06:47 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 16:06:47 INFO - Successfully installed simplejson 16:06:47 INFO - Cleaning up... 16:06:48 INFO - Return code: 0 16:06:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:48 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 0x21671f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, '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-1507071515.817658-771847013', '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 16:06:48 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 16:06:48 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 16:06:48 INFO - Using env: {'DISPLAY': ':0', 16:06:48 INFO - 'HOME': '/home/cltbld', 16:06:48 INFO - 'LANG': 'en_US.UTF-8', 16:06:48 INFO - 'LANGUAGE': 'en_US:en', 16:06:48 INFO - 'LOGNAME': 'cltbld', 16:06:48 INFO - 'MAIL': '/var/mail/cltbld', 16:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:48 INFO - 'MOZ_NO_REMOTE': '1', 16:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:48 INFO - 'NO_EM_RESTART': '1', 16:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:48 INFO - 'PWD': '/builds/slave/test', 16:06:48 INFO - 'SHELL': '/bin/bash', 16:06:48 INFO - 'SHLVL': '1', 16:06:48 INFO - 'TERM': 'linux', 16:06:48 INFO - 'TMOUT': '86400', 16:06:48 INFO - 'USER': 'cltbld', 16:06:48 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:48 INFO - '_': '/tools/buildbot/bin/python'} 16:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:48 INFO - Cleaning up... 16:06:48 INFO - Return code: 0 16:06:48 INFO - Running post-action listener: _resource_record_post_action 16:06:48 INFO - Running post-action listener: _start_resource_monitoring 16:06:48 INFO - Starting resource monitoring. 16:06:48 INFO - [mozharness: 2017-10-03 23:06:48.292362Z] Finished create-virtualenv step (success) 16:06:48 INFO - [mozharness: 2017-10-03 23:06:48.293330Z] Running install step. 16:06:48 INFO - Running pre-action listener: _resource_record_pre_action 16:06:48 INFO - Running main action method: install 16:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:48 INFO - Reading from file tmpfile_stdout 16:06:48 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:48 INFO - Reading from file tmpfile_stdout 16:06:48 INFO - Output received: 16:06:48 INFO - Usage: mozinstall [options] installer 16:06:48 INFO - Options: 16:06:48 INFO - -h, --help show this help message and exit 16:06:48 INFO - -d DEST, --destination=DEST 16:06:48 INFO - Directory to install application into. [default: 16:06:48 INFO - "/builds/slave/test"] 16:06:48 INFO - --app=APP Application being installed. [default: firefox] 16:06:48 INFO - mkdir: /builds/slave/test/build/application 16:06:48 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'] 16:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:07:06 INFO - Reading from file tmpfile_stdout 16:07:06 INFO - Output received: 16:07:06 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:06 INFO - Running post-action listener: _resource_record_post_action 16:07:06 INFO - [mozharness: 2017-10-03 23:07:06.220918Z] Finished install step (success) 16:07:06 INFO - [mozharness: 2017-10-03 23:07:06.221065Z] Running setup-mitmproxy step. 16:07:06 INFO - Running pre-action listener: _resource_record_pre_action 16:07:06 INFO - Running main action method: setup_mitmproxy 16:07:06 INFO - Skipping: mitmproxy is not required 16:07:06 INFO - Running post-action listener: _resource_record_post_action 16:07:06 INFO - [mozharness: 2017-10-03 23:07:06.221723Z] Finished setup-mitmproxy step (success) 16:07:06 INFO - [mozharness: 2017-10-03 23:07:06.221834Z] Running run-tests step. 16:07:06 INFO - Running pre-action listener: _resource_record_pre_action 16:07:06 INFO - Running pre-action listener: _set_gcov_prefix 16:07:06 INFO - Running main action method: run_tests 16:07:06 WARNING - Try message not found. 16:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:06 INFO - Python 2.7.3 16:07:06 INFO - Return code: 0 16:07:06 INFO - grabbing minidump binary from tooltool 16:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:07:06 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 0x24d1d60>, '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 0x24d2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d2ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:06 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 16:07:06 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 16:07:06 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 16:07:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:06 INFO - Return code: 0 16:07:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:06 INFO - ENV: RUST_BACKTRACE is now full 16:07:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/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-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:07:06 INFO - Using env: {'DISPLAY': ':0', 16:07:06 INFO - 'HOME': '/home/cltbld', 16:07:06 INFO - 'LANG': 'en_US.UTF-8', 16:07:06 INFO - 'LANGUAGE': 'en_US:en', 16:07:06 INFO - 'LOGNAME': 'cltbld', 16:07:06 INFO - 'MAIL': '/var/mail/cltbld', 16:07:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:06 INFO - 'MOZ_NO_REMOTE': '1', 16:07:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:06 INFO - 'NO_EM_RESTART': '1', 16:07:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:06 INFO - 'PWD': '/builds/slave/test', 16:07:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:06 INFO - 'RUST_BACKTRACE': 'full', 16:07:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:07:06 INFO - 'SHELL': '/bin/bash', 16:07:06 INFO - 'SHLVL': '1', 16:07:06 INFO - 'TERM': 'linux', 16:07:06 INFO - 'TMOUT': '86400', 16:07:06 INFO - 'USER': 'cltbld', 16:07:06 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:06 INFO - '_': '/tools/buildbot/bin/python'} 16:07:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:07:06 INFO - mozversion application_buildid: 20171003213749 16:07:06 INFO - mozversion application_changeset: c97190c389c4cfef20fe55b4bacade95a36ae6ef 16:07:06 INFO - mozversion application_display_name: Nightly 16:07:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:06 INFO - mozversion application_name: Firefox 16:07:06 INFO - mozversion application_remotingname: firefox 16:07:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:07:06 INFO - mozversion application_vendor: Mozilla 16:07:06 INFO - mozversion application_version: 58.0a1 16:07:06 INFO - mozversion platform_buildid: 20171003213749 16:07:06 INFO - mozversion platform_changeset: c97190c389c4cfef20fe55b4bacade95a36ae6ef 16:07:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:07:06 INFO - mozversion platform_version: 58.0a1 16:07:06 INFO - using testdate: 1507072026 16:07:06 INFO - actual date: 1507072026 16:07:06 INFO - starting webserver on 'localhost:38851' 16:07:06 INFO - SUITE-START | Running 2 tests 16:07:06 INFO - TEST-START | dromaeo_css 16:07:06 INFO - Initialising browser for dromaeo_css test... 16:07:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38851/getInfo.html -profile /tmp/tmpyib7Ns/profile 16:07:06 INFO - TEST-INFO | started process 3642 (/builds/slave/test/build/application/firefox/firefox http://localhost:38851/getInfo.html) 16:07:14 INFO - TEST-INFO | 3642: exit 0 16:07:14 INFO - Browser initialized. 16:07:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:14 INFO - Using env: {'DISPLAY': ':0', 16:07:14 INFO - 'HOME': '/home/cltbld', 16:07:14 INFO - 'JSGC_DISABLE_POISONING': '1', 16:07:14 INFO - 'LANG': 'en_US.UTF-8', 16:07:14 INFO - 'LANGUAGE': 'en_US:en', 16:07:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:07:14 INFO - 'LOGNAME': 'cltbld', 16:07:14 INFO - 'MAIL': '/var/mail/cltbld', 16:07:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:14 INFO - 'MOZ_CRASHREPORTER': '1', 16:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:07:14 INFO - 'MOZ_NO_REMOTE': '1', 16:07:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:14 INFO - 'NO_EM_RESTART': '1', 16:07:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:14 INFO - 'PWD': '/builds/slave/test', 16:07:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:14 INFO - 'RUST_BACKTRACE': 'full', 16:07:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:07:14 INFO - 'SHELL': '/bin/bash', 16:07:14 INFO - 'SHLVL': '1', 16:07:14 INFO - 'STYLO_FORCE_DISABLED': '1', 16:07:14 INFO - 'TERM': 'linux', 16:07:14 INFO - 'TMOUT': '86400', 16:07:14 INFO - 'USER': 'cltbld', 16:07:14 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:14 INFO - '_': '/tools/buildbot/bin/python'} 16:07:14 INFO - TEST-INFO | started process 3922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyib7Ns/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:15 INFO - PID 3922 | 16:07:15 INFO - PID 3922 | (/builds/slave/test/build/application/firefox/firefox:3973): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:07:15 INFO - PID 3922 | 16:07:25 INFO - PID 3922 | RSS: Main: 142368768 16:07:25 INFO - PID 3922 | 16:10:22 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38851/tests/dromaeo/cssquery-ext.html) 16:10:24 INFO - PID 3922 | RSS: Main: 143065088 16:10:24 INFO - PID 3922 | 16:13:25 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-ext.html (next: http://localhost:38851/tests/dromaeo/cssquery-jquery.html) 16:13:26 INFO - PID 3922 | RSS: Main: 142348288 16:13:26 INFO - PID 3922 | 16:16:28 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38851/tests/dromaeo/cssquery-mootools.html) 16:16:28 INFO - PID 3922 | RSS: Main: 145031168 16:16:28 INFO - PID 3922 | 16:19:30 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38851/tests/dromaeo/cssquery-prototype.html) 16:19:30 INFO - PID 3922 | RSS: Main: 144793600 16:19:30 INFO - PID 3922 | 16:22:33 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38851/tests/dromaeo/cssquery-yui.html) 16:22:34 INFO - PID 3922 | RSS: Main: 148099072 16:22:34 INFO - PID 3922 | 16:25:35 INFO - PID 3922 | Cycle 1(1): loaded http://localhost:38851/tests/dromaeo/cssquery-yui.html (next: http://localhost:38851/tests/dromaeo/cssquery-dojo.html) 16:25:35 INFO - PID 3922 | RSS: Main: 149151744 16:25:35 INFO - PID 3922 | 16:25:35 INFO - PID 3922 | __start_tp_report 16:25:35 INFO - PID 3922 | _x_x_mozilla_page_load 16:25:35 INFO - PID 3922 | _x_x_mozilla_page_load_details 16:25:35 INFO - PID 3922 | |i|pagename|runs| 16:25:35 INFO - PID 3922 | |0;dojo.html;3855.997440665426;3860.478835357226;3872.1674839909415;3874.225154969007;3874.7481413708124;6188.195534580509;6231.22109736283;6265.809496195725;6309.589876658019;6344.365563443647;6261.530385221104;6274.686265686721;6285.277193122793;6301.275353334357;6301.905471417932;5582.86042848928;5618.438156184389;5631.042722737124;5640.576956728261;5648.915266271009;5632.943670563303;5706.914396284059;5732.0828667413225;5747.252857128588;5752.1084231943905;5692.9146062809095;5708.571857110713;5727.312722473288;5734.311882574097;5774.018416869121;5511.58663100265;5637.3235211774845;5722.59941804076;5796.82609521715;5797.391273916221;5302.734863256822;5555.083411237141;5602;5629.915551266734;5697.430256974311;6282.937170628326;6297.527685423612;6301.6534090625;6344.619322840645;6362.141110950009;6782.966085169543;6831.9658401707675;6865.0732151159955;6903.620300883449;6951.93048069523;6930.30696930308;6946.6179360135175;6961.686724097377;6969.47728920328;6973.476989225828;6306.085617585471;6315.147455093595;6340.112384266206;6407.135036770023;6416.903746443761;6855.314468553105;7037.859242815115;7046.964765176142;7127.679254433563;7129.607871567114;6734.932650673529;6742.157230346207;6816.488763342769;6843.315668433117;6856.451483881277;6856.074429951992;6858.759943401957;6928.861422771617;6940;6991.23096459389;6793.966030169916;6808.489363297773;6808.557443766139;6894.310568943066;6906.482013848981;6836.145481814773;6856.074429951992;6919.550229235084;6922.965385173042;6927.792166235021;5075.0357432087785;5093.0577843099145;5097.158968770112;5103.030424219386;5109.846704598868;4496.775161241925;4499.635204955221;4541.909161816745;4567.2920697291975;4572.611328037154;6198.349173336825;6267.749290028348;6276.184096067482;6276.686165691697;6278.717457714414;6821.045053692487;6832;6833.077534532775;6834.692438840264;6836.760713375008;6147.354527774609;6155.938440615626;6163.445289923929;6171.413715697002;6177.722002509898;5462.399136095027;5482.725863706799;5546.473085056913;5558.861028474321;5577.581681373832;6898.620575868375;7002.124734408199;7123.501354905211;7126.821829454305;7249.347558719741;6899.448044156355;6909.654517274217;6911.654417279216;6930.341617546325;6938.098047253825;7062.293770623102;7085.681144348414;7141.714331426685;7153.177384600629;7165.462590305644;6779.389854913082;6783.93216067833;6847.760328388483;6870.20992585859;6872.41584465306;6738;6788.728450862108;6869.931300686929;6871.931280687129;6879.3120687930805;6648.401643851883;6700.664966751546;6706.497012723968;6709.7651582194385;6711.731530738911;6567.146270984741;6607.603543787388;6614.801555953329;6692.966535167293;6714.462842972648;6535;6535.5425120241125;6585.3085426029575;6629.436497897733;6640.867182656417;6598.868022639616;6615.6030638161865;6679.966600166968;6736.5958042517605;6758.5269031167345;6438.356164383524;6480.57876238043;6498.187726534184;6508.186476690414;6509.218893732593 16:25:35 INFO - PID 3922 | |1;ext.html;894.3873446689023;976.858355538447;1007.496251874063;1008.5108722269698;1010.0606436014508;46187.30719039213;46862;46972;46982.060358792805;46991.530084699145;44465;44582.777086114525;44651.1069778605;44731.105377892505;44819.32771008438;7755.302022817959;7834.843303133934;7862.135165131831;7862.135165131831;7874.291313781759;7804.3756499479905;7852.921470785276;7869.331106855924;7869.449138560303;7881.05427348719;8342.791430214233;8463.788405289886;8471.915280847204;8483.915160848404;8485.915140848574;8366.790830229233;8412.36907231957;8422.199891010345;8423.663053477883;8425.662973481054;8259.545724985124;8396.748097557083;8408.159184081544;8408.663653453854;8413.032501262373;41610.167796643895;41618.79190604058;41748.37377439341;41916.1616767666;42182.156356873;3487.1805125795418;3525.8765943191866;3526.929461410783;3528.6471352864764;3530.5233793437815;33323;33341.666583334096;33383.83308083444;33456.665433345595;33636.83181584101;5549.306336707911;5551.084071128259;5559.777608895639;5605.7197140142825;5624.21261023457;215894.92052539793;216514;216695;216707;216757;48987;49408.50591494111;49518;49547;50781;51395.48604513907;51465.22802157971;51649.741751291;51754.48245517497;51874;15527.76708349353;15634.140122293384;15661.138637375054;15676.843231567766;15695.764563531557;12155.331456769962;12176.208546444454;12243.142979991315;12281.754364912831;12284.324362159989;16103.758443623356;16138.515844524683;16165.757513637305;16167.272472738756;16218.675626487404;6282.780102696383;6341.619502829845;6368.872622547616;6400.135981642418;6458.354164583504;1068.556549032143;1083.5124194112682;1088.2599832114238;1100.4222783038967;1103.426218366445;26158.476830463285;26223.73776262251;26308.342291442485;26473.205803825917;26612.60081098785;1187.4181650990952;1189.2448295332526;1208.2750349790056;1220.7375414285793;1225.2770865189582;13811.861881381259;13816.309184540733;13914.234717090454;13928.651783705489;14094.224817635128;279229;281825;281954;282093;282885;60859.39140608626;61067;61433.38566614366;61458.69270653618;61726;1517.4233791159509;1523.428714232163;1566.9138197399025;1581.0710932662134;1590.6023494126468;25578;25601.74398256068;25602.103926362488;25680.61479077778;25878.741212587633;43575.12849743051;43727.34408983804;43790;43857.56142438535;43920.34119488274;247014;247411;260735;264813;265804;35377.1155721109;36177.105831532885;39514.20971580495;39740.40389394104;40205.1958960825;51294.74352628213;51945.22082168846;52047.73976130095;52231;52779.73610131925;38179.80910095432;38373.424398633484;38391;38543;38560.80719596384;37991.43012854864;38046.61953380542;38048.80975595215;38113.80943095267;38341.23317533689;43419;44343.77828110839;44863.55136448594;44904.550954491344;44916.326255106855;36418.63581364152;36578.8171059143;36749;36784.63215367812;36972.26055478929;27239.59140612932;27465.45069098647;27627.30931726723;27729.861350693925;27936 16:25:35 INFO - PID 3922 | |2;jquery.html;623.2154883751813;633.0270816297082;634.0841971162199;645.0219425272688;647.3678992762962;23318.88340558299;24284.150054748086;24402.511949761018;24445.87777061112;24448.266552003424;25436.491270174585;26358.077467288647;26399.3400164996;26413.075542356022;26799.732002680015;6843.8973415398805;7018.298170182992;7025.754098606524;7026.262242464544;7029;6487.578307410027;6719.428848547879;6733.225679046924;6855.108835851357;6917.308269173092;6707.932920670804;6714.362135597111;6715.395614394703;6715.764948226813;6721.663916804165;6635.469162466991;6673.199216094051;6711.798646040626;6717.697703603325;6717.832054198635;6224.719887605069;6235.657038862861;6243.313235544132;6265.8120256392385;6276.843078923018;26825;27403.45193096127;28100.297492562848;28288.15135545937;28512;2305.4005958450757;2339.415146213447;2358.1157066100213;2364.219807463533;2367.5028244068767;19859.50351241216;20922.37232883016;21776.346709598736;21822.890885545472;21865;2585.909493167749;2588.184721812623;2633.9604905926235;2651.5549025780997;2666.213467027212;162542.1872890628;166213;174811;182371;183897;15360.923195383952;16326.673466530603;16398;16493.752593711102;16627.584310392336;25304.493910122063;25535.74464255371;25586.872065639553;25589;25625.10312139066;10153.847692284622;10612.20408469368;10673.146148308117;10835.404052777016;10868.184886133571;9620.90379096214;9629.229661627052;9748.463834489172;9932.155766759906;9950.502474876228;9205.76985575366;9513.857292140623;9566;9593.952030239805;9659.855102173473;2884.7259510346903;2888.653361596622;2892.9276768080967;3099.1560021787;3114.7819652624553;1033.7415646088477;1064.797688439194;1073.1951036722458;1076.5747529725716;1078.5577913055608;21627.24304649361;21909.452263693536;22023;22050.11799528033;22175.66736498954;1123.1407972900738;1131.7057565033151;1134.8638163420442;1135.2110283353156;1144.2390810111183;11747.353895535827;11990.940045299718;12136.393180341125;12154.696132596579;12216.450259738333;622607;632596;634823;642415;648781;122378.38810805889;122859;123904.38047809704;124393;126573;1246.719488115185;1254.9623511294676;1284.0305569295308;1288.2592509307185;1291.1930043722673;19327.8067219326;19409.51476213106;19449.902750486723;19471.026448677225;19679;61395.69302153461;62446.06330905131;62501;63323.6833815828;64424;77153.61423192848;77803;77914.22085779297;78908;78912.21087789048;15236.162011089496;15286.617834554225;15342.15618141013;15376.84623153799;15377.769333459783;22840.657390139495;22884.771152288264;22949.770502294763;23012.07951681981;23077.961491732578;18495.167717453016;18592.628147437244;18799.06004699732;19102.33141840029;19111.139998699815;16523.917380413022;16761.91619041897;17047.8918870278;17176.484705458857;17301.13494325304;18049.278028878696;19201;19356;19461.51346216299;19468.415947521597;15107.39570417171;15110.093394396372;15119.395224191348;15154.393824246907;15176.089434633957;18338.26646934161;18400.53998649991;18649.720254195927;18715.625687486445;18909.810901890804 16:25:35 INFO - PID 3922 | |3;mootools.html;1271.9872801271988;1308.9934550327248;1315.375196781529;1315.4803852478271;1317.9670508237286;16883.57791055224;18181.999999999967;18195.54511137219;18247.908760456197;18297.817021829793;17863.10684465778;18148.455546333596;18152;18156.63686726265;18194.63610727788;2691.3944362518473;2710.7018227994904;2742.1362270884706;2748.4365705030423;2751;2428.9271321860374;2502.5245203411387;2541.8601976891264;2542.1102614085016;2545.4272788622598;2592.41670624109;2617.9214623561325;2660.1088635307196;2661.9068332608363;2662.960055599158;2440.1825388494785;2482.2677310193535;2483.1309041835393;2489.153687746175;2499.212747984388;2397.1969390254285;2410.3130607776698;2410.6384042393606;2414.9637755433682;2416.7099948006176;16295.429659961845;16438.095904725236;16504.25730842115;16508;16553.337866485326;8094.473859199192;8305.044919834176;8314.085450600429;8340.249377555989;8356;5499.835004949858;5678.4605462480995;5754.223179870705;5804.042333015047;5827.533797296206;2177.6624623183434;2199.8790066546335;2202.4383782135615;2203.2398822406403;2255.8984845681985;30913.072607821803;30958.690413096032;31051.37897242065;31270.687293127005;31279.218019549466;7131.429485641136;7209.279072092749;7247.565146091251;7370.262973702587;7383.187849336568;19262.80737192638;19390.224391024483;19396;19409.902950485157;19440.611187776165;8292.958535207406;8513.19124683154;8528.147185281547;8546.700865469804;8583.914160858312;7604.961975190088;7727.690892364355;7759.57322347265;7761.573113478813;7772.533647981139;5903.409659034062;5957.702114894238;5987;5989.221401217814;6128.662923539248;1693.4665580342153;1711.880168388201;1742.4075814222972;1760.7270873014447;1770.2564922732483;930.1070971866948;937.2595649436869;941.8634298026885;946.7254496196026;950.9429434233969;8238.794030149294;8294.626741796634;8302.252797248157;8364.749057528285;8376.162383761697;737.6643627149634;751.5190278221943;756.3797685897512;761.5697131120899;762.3024932187097;5634.267545219177;5734.655920644775;5771.538276937835;5776.624519406225;5841.357450680422;25012.124575639766;25674.229773106836;26008.609870851953;26218.606720899203;26284.605730914052;24630.876845615658;25211.74788252094;25224.74775252224;25254.116105936573;25570.360740981254;11781.823272650918;11842.703932401759;12153.5138594457;12173.573924912585;12457.563985260653;9099.954500227457;9162.816743665222;9167.358284919992;9184.954075229582;9185.908140918506;20612.278570249968;21030.47423814417;21313.89343053275;21592.67610985868;21784.782152178275;22018.339449816533;22102.00540975628;22313.665295020914;22331.10675572959;22367.77632223722;12228.633141005785;12250.754984900073;12325.445354958869;12388.752224955631;12471.563495277622;15732.292046858147;15771.369145234063;15801.68396632084;15916.920415397848;15942.362305508113;12649.177803443115;12663.303518306582;12804.679883002627;12813.423395947018;12925.676858078623;11686.065114790967;11788;11901;12021.278723276631;12126.151169418055;11210;11453.828192576952;11476.483558239732;11485.425728713699;11488.770224595628;7779.844403111792;7999.280064794197;8070;8117.918820811717;8214.671413143407;8076.87884681742;8099.109097999333;8100.432969692065;8197.180281971756;8230.21812927771 16:25:35 INFO - PID 3922 | |4;prototype.html;550.9696966666834;578.3869098755322;582.3623132669725;586.4135864135864;590.4243362721346;6349.968250158743;6365.52258580606;6368.649724265169;6376.107344971701;6428.550001499897;6265.874682506347;6306.873862522747;6344.873102537958;6363.204599425072;6411.551191416591;5189.455107213745;5201.271821944931;5216.76524556394;5217.191335343009;5244.947550524484;4994.200927851544;5199.792008319662;5214.530692237698;5260;5261.289725887013;4977.601791856643;4995.275685025669;4996.800127994894;5021.6986980781085;5032.540563236657;5029.164355010432;5041.773120209563;5043.470435604282;5056.898862022776;5058.114829904752;4565.406497155382;4568.634509239253;4590.563896429834;4600.815967361302;4631.560001799858;6149.2313460817395;6201.658908760016;6245.937540624581;6334.87330253397;6382.1384113144595;5954.732037058299;6011.639301641915;6018.6689732064715;6030.879382412327;6049.396909818902;6711.731530738764;6752.493562982747;6755.256921738604;6796.966015169942;6846.828829279308;5127.692638248346;5152.974235128838;5160.664556803796;5180.740962951837;5195;6749.865002699968;6858.51990360675;6984.965075174642;6994.68523916425;7054.5061845670825;5232.319798426181;5262.736863156827;5303.973480132575;5356.7589458473685;5386.5152136307925;5380.515753582196;5434.3207099112615;5434.777175135563;5435.320584926884;5455.645383050169;6017.308009578955;6022.638641681513;6038.607490513103;6043.969780151071;6045.818625441244;6757.932420675828;6808.761693340709;6820.795376138723;6835.453163746888;6874.828129296808;1845.7231415287815;1848.9630207395776;1857.786354569242;1862.4785060183171;1865.9253629854925;1283.5186804948144;1351.2770667692737;1352.6280272925023;1353.4315587453293;1359.3475131936527;6272.8118156455375;6283.6858157091965;6287.208145678551;6288.5598008139905;6304.495640348761;6755.392014718699;6789.25318214996;6870.656467176621;6875.518713689994;6886.827829304308;6290.182276304143;6304.716287767062;6334.588251763621;6398.168238129014;6400.167978162809;3544.326577950181;3588.659077387644;3590.4793804898145;3604.459331100356;3626.7461277710836;6992.370686638125;7152.749653762094;7155.92844071563;7217.9639101805205;7222.96388518054;7020.543664661781;7027.89458158128;7034;7035.929640703527;7144.678489467987;6964.930350696428;7007.334303241082;7053.929460705327;7085.441202935346;7157.24848890859;6754.493412994143;6769.849125648553;6781.254062053072;6827.829304267433;6856.965715171592;6723.327667233238;6725.663716814238;6760.966195168992;6769.729210831709;6853.143357080365;6929.237783843672;7025.648717564203;7033.542819716702;7041.3310735480045;7051.153861536648;5231.973840130775;5280.313559237275;5317.075608415279;5320.920186197132;5357.303550538405;6658.267590565131;6861.250381152774;6879.6560171992205;6889.827754305982;6914.55055421396;6530.608163510205;6633.402993730588;6634.734610615521;6670.232923213698;6737.9326206737305;6558.967205163944;6582.539222254396;6687.966560167362;6714;6759.695813688494;6380.776672816429;6481;6514.54398192122;6585.715785421989;6619.735210591522;6514.706838192198;6518.478521718346;6584.76953306632;6640.83397915056;6700.46396288286;6404.231492220777;6430.324815894263;6445.291017987924;6458.22501299847;6492.253390859923 16:25:35 INFO - PID 3922 | |5;yui.html;920.6869664314136;957.1242313283346;994.5077186792537;1008.9607704064814;1014.3406785589361;19000.144993475293;19403;19406.320778772744;19461.318853840137;23898;21064.578708425823;21199.364019079454;21209.787902120974;21232.363029109114;21254.362369128914;1010.3786171504545;1012.0436187802529;1012.0891197921856;1012.3622118065608;1045.7333379988092;1049.4385503755493;1078.3152698036763;1085.793699197154;1085.8262677971527;1088.1186239146316;1132.8357388178708;1133.0142775785077;1140.4696815980567;1141.6746227325214;1143.0284258380352;1113.883042280561;1124.2579897267765;1124.550179928027;1126.9774604507904;1127.334872425269;830.6760363458257;831.6465502161557;836.6695155413638;837.3134030095324;837.6691206973211;20179.293724719566;20859.687104693443;21011.36965891026;21015.369538913856;21342.146314147416;21034.158633654635;22228;22624.434389140402;22640.320790376314;22649.660255096187;18732.15705293265;19070.809291907182;19076.809231907642;19166.329178478685;19287.22851085955;4048.251073551373;4048.271311163989;4088.366303223005;4092.6725861930972;4092.9181416371803;170772;172385;172798;175087;175302;18609.81390186081;18692.252309907723;18733.906330468533;18861.434156975312;18973.620527589646;33474.832625836716;33587.328253435284;34248.31503369919;34302;34342.65657343445;8394.958025209957;8504.957475212708;8546.871796923051;8593.742187734379;8607.698730544525;3915.5888631693833;4027.496562929634;4152.709310348307;4263.701540892108;4275.893102672458;5930.7924222652;6042.909356359658;6043.365446628129;6057.000594901792;6060.636361818305;1231.1812644591425;1252.8997680185564;1255.2593969558004;1265.5950095969201;1272.5291642092484;709.7303024850523;714.8570285942832;715.3811952660911;715.713714514188;735.4300417176731;12685;13108.50938321735;13165.53920612774;13278.800817987738;13498;678.8506528563709;687.5874475314871;692.7367600311849;705.3369832357567;711.3988679565758;5827.79602713903;5842.669678283338;5845.41545845412;5924.7333869975955;6021.187139736079;157721;161442;161586;164181;166312;146386;146561;148641;148995;151512.2424387893;123300;124175;124384;125444;126937.36531317285;11555.71110722205;11632.88367116318;11768;11883.82174267404;11925.0459963201;61472;61509.692451537456;62161.689191553756;63246.36753632405;63375.36624633695;74576.25423745693;75813;76989;77719.61140194263;78434;16657.167141642625;16789;16789;16922.15389230558;17000.57498562546;19060.332888348843;19159.329423470113;19170.90414547974;19277.421677349703;19377.8062219376;18019.189136489153;18236.726449103007;18256.543586410447;18439.72340414868;18452.630947381247;17377.957322560687;17396.565085872953;17421.564460888578;17474.30102795925;17582.20880060375;17042.147892605073;17364.73952890733;17412.738808917624;17415.21631526559;17607.647847043245;12027.939860300643;12254.938725306672;12397.93801030989;12524.248545087325;12579.93710031444;13473.797893031808;13529.59411217665;13557.661058473617;13628;13629.795553066513 16:25:35 INFO - PID 3922 | __end_tp_report 16:25:35 INFO - PID 3922 | __start_cc_report 16:25:35 INFO - PID 3922 | _x_x_mozilla_cycle_collect,271 16:25:35 INFO - PID 3922 | __end_cc_report 16:25:35 INFO - PID 3922 | __startTimestamp1507073135982__endTimestamp 16:25:35 INFO - PID 3922 | 16:25:35 INFO - PID 3922 | ------- Summary: start ------- 16:25:35 INFO - PID 3922 | Number of tests: 6 16:25:35 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#0] dojo.html Cycles:165 Average:6303.00 Median:6567.15 stddev:758.33 (11.5%) stddev-sans-first:735.96 16:25:36 INFO - PID 3922 | Values: 3856.0 3860.5 3872.2 3874.2 3874.7 6188.2 6231.2 6265.8 6309.6 6344.4 6261.5 6274.7 6285.3 6301.3 6301.9 5582.9 5618.4 5631.0 5640.6 5648.9 5632.9 5706.9 5732.1 5747.3 5752.1 5692.9 5708.6 5727.3 5734.3 5774.0 5511.6 5637.3 5722.6 5796.8 5797.4 5302.7 5555.1 5602.0 5629.9 5697.4 6282.9 6297.5 6301.7 6344.6 6362.1 6783.0 6832.0 6865.1 6903.6 6951.9 6930.3 6946.6 6961.7 6969.5 6973.5 6306.1 6315.1 6340.1 6407.1 6416.9 6855.3 7037.9 7047.0 7127.7 7129.6 6734.9 6742.2 6816.5 6843.3 6856.5 6856.1 6858.8 6928.9 6940.0 6991.2 6794.0 6808.5 6808.6 6894.3 6906.5 6836.1 6856.1 6919.6 6923.0 6927.8 5075.0 5093.1 5097.2 5103.0 5109.8 4496.8 4499.6 4541.9 4567.3 4572.6 6198.3 6267.7 6276.2 6276.7 6278.7 6821.0 6832.0 6833.1 6834.7 6836.8 6147.4 6155.9 6163.4 6171.4 6177.7 5462.4 5482.7 5546.5 5558.9 5577.6 6898.6 7002.1 7123.5 7126.8 7249.3 6899.4 6909.7 6911.7 6930.3 6938.1 7062.3 7085.7 7141.7 7153.2 7165.5 6779.4 6783.9 6847.8 6870.2 6872.4 6738.0 6788.7 6869.9 6871.9 6879.3 6648.4 6700.7 6706.5 6709.8 6711.7 6567.1 6607.6 6614.8 6693.0 6714.5 6535.0 6535.5 6585.3 6629.4 6640.9 6598.9 6615.6 6680.0 6736.6 6758.5 6438.4 6480.6 6498.2 6508.2 6509.2 16:25:36 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#1] ext.html Cycles:180 Average:43752.20 Median:38357.33 stddev:65828.37 (171.6%) stddev-sans-first:65934.38 16:25:36 INFO - PID 3922 | Values: 894.4 976.9 1007.5 1008.5 1010.1 46187.3 46862.0 46972.0 46982.1 46991.5 44465.0 44582.8 44651.1 44731.1 44819.3 7755.3 7834.8 7862.1 7862.1 7874.3 7804.4 7852.9 7869.3 7869.4 7881.1 8342.8 8463.8 8471.9 8483.9 8485.9 8366.8 8412.4 8422.2 8423.7 8425.7 8259.5 8396.7 8408.2 8408.7 8413.0 41610.2 41618.8 41748.4 41916.2 42182.2 3487.2 3525.9 3526.9 3528.6 3530.5 33323.0 33341.7 33383.8 33456.7 33636.8 5549.3 5551.1 5559.8 5605.7 5624.2 215894.9 216514.0 216695.0 216707.0 216757.0 48987.0 49408.5 49518.0 49547.0 50781.0 51395.5 51465.2 51649.7 51754.5 51874.0 15527.8 15634.1 15661.1 15676.8 15695.8 12155.3 12176.2 12243.1 12281.8 12284.3 16103.8 16138.5 16165.8 16167.3 16218.7 6282.8 6341.6 6368.9 6400.1 6458.4 1068.6 1083.5 1088.3 1100.4 1103.4 26158.5 26223.7 26308.3 26473.2 26612.6 1187.4 1189.2 1208.3 1220.7 1225.3 13811.9 13816.3 13914.2 13928.7 14094.2 279229.0 281825.0 281954.0 282093.0 282885.0 60859.4 61067.0 61433.4 61458.7 61726.0 1517.4 1523.4 1566.9 1581.1 1590.6 25578.0 25601.7 25602.1 25680.6 25878.7 43575.1 43727.3 43790.0 43857.6 43920.3 247014.0 247411.0 260735.0 264813.0 265804.0 35377.1 36177.1 39514.2 39740.4 40205.2 51294.7 51945.2 52047.7 52231.0 52779.7 38179.8 38373.4 38391.0 38543.0 38560.8 37991.4 38046.6 38048.8 38113.8 38341.2 43419.0 44343.8 44863.6 44904.6 44916.3 36418.6 36578.8 36749.0 36784.6 36972.3 27239.6 27465.5 27627.3 27729.9 27936.0 16:25:36 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#2] jquery.html Cycles:180 Average:40895.22 Median:23198.42 stddev:106724.90 (460.1%) stddev-sans-first:106981.45 16:25:36 INFO - PID 3922 | Values: 623.2 633.0 634.1 645.0 647.4 23318.9 24284.2 24402.5 24445.9 24448.3 25436.5 26358.1 26399.3 26413.1 26799.7 6843.9 7018.3 7025.8 7026.3 7029.0 6487.6 6719.4 6733.2 6855.1 6917.3 6707.9 6714.4 6715.4 6715.8 6721.7 6635.5 6673.2 6711.8 6717.7 6717.8 6224.7 6235.7 6243.3 6265.8 6276.8 26825.0 27403.5 28100.3 28288.2 28512.0 2305.4 2339.4 2358.1 2364.2 2367.5 19859.5 20922.4 21776.3 21822.9 21865.0 2585.9 2588.2 2634.0 2651.6 2666.2 162542.2 166213.0 174811.0 182371.0 183897.0 15360.9 16326.7 16398.0 16493.8 16627.6 25304.5 25535.7 25586.9 25589.0 25625.1 10153.8 10612.2 10673.1 10835.4 10868.2 9620.9 9629.2 9748.5 9932.2 9950.5 9205.8 9513.9 9566.0 9594.0 9659.9 2884.7 2888.7 2892.9 3099.2 3114.8 1033.7 1064.8 1073.2 1076.6 1078.6 21627.2 21909.5 22023.0 22050.1 22175.7 1123.1 1131.7 1134.9 1135.2 1144.2 11747.4 11990.9 12136.4 12154.7 12216.5 622607.0 632596.0 634823.0 642415.0 648781.0 122378.4 122859.0 123904.4 124393.0 126573.0 1246.7 1255.0 1284.0 1288.3 1291.2 19327.8 19409.5 19449.9 19471.0 19679.0 61395.7 62446.1 62501.0 63323.7 64424.0 77153.6 77803.0 77914.2 78908.0 78912.2 15236.2 15286.6 15342.2 15376.8 15377.8 22840.7 22884.8 22949.8 23012.1 23078.0 18495.2 18592.6 18799.1 19102.3 19111.1 16523.9 16761.9 17047.9 17176.5 17301.1 18049.3 19201.0 19356.0 19461.5 19468.4 15107.4 15110.1 15119.4 15154.4 15176.1 18338.3 18400.5 18649.7 18715.6 18909.8 16:25:36 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#3] mootools.html Cycles:180 Average:10456.92 Median:25239.43 stddev:7914.99 (31.4%) stddev-sans-first:7907.11 16:25:36 INFO - PID 3922 | Values: 1272.0 1309.0 1315.4 1315.5 1318.0 16883.6 18182.0 18195.5 18247.9 18297.8 17863.1 18148.5 18152.0 18156.6 18194.6 2691.4 2710.7 2742.1 2748.4 2751.0 2428.9 2502.5 2541.9 2542.1 2545.4 2592.4 2617.9 2660.1 2661.9 2663.0 2440.2 2482.3 2483.1 2489.2 2499.2 2397.2 2410.3 2410.6 2415.0 2416.7 16295.4 16438.1 16504.3 16508.0 16553.3 8094.5 8305.0 8314.1 8340.2 8356.0 5499.8 5678.5 5754.2 5804.0 5827.5 2177.7 2199.9 2202.4 2203.2 2255.9 30913.1 30958.7 31051.4 31270.7 31279.2 7131.4 7209.3 7247.6 7370.3 7383.2 19262.8 19390.2 19396.0 19409.9 19440.6 8293.0 8513.2 8528.1 8546.7 8583.9 7605.0 7727.7 7759.6 7761.6 7772.5 5903.4 5957.7 5987.0 5989.2 6128.7 1693.5 1711.9 1742.4 1760.7 1770.3 930.1 937.3 941.9 946.7 950.9 8238.8 8294.6 8302.3 8364.7 8376.2 737.7 751.5 756.4 761.6 762.3 5634.3 5734.7 5771.5 5776.6 5841.4 25012.1 25674.2 26008.6 26218.6 26284.6 24630.9 25211.7 25224.7 25254.1 25570.4 11781.8 11842.7 12153.5 12173.6 12457.6 9100.0 9162.8 9167.4 9185.0 9185.9 20612.3 21030.5 21313.9 21592.7 21784.8 22018.3 22102.0 22313.7 22331.1 22367.8 12228.6 12250.8 12325.4 12388.8 12471.6 15732.3 15771.4 15801.7 15916.9 15942.4 12649.2 12663.3 12804.7 12813.4 12925.7 11686.1 11788.0 11901.0 12021.3 12126.2 11210.0 11453.8 11476.5 11485.4 11488.8 7779.8 7999.3 8070.0 8117.9 8214.7 8076.9 8099.1 8100.4 8197.2 8230.2 16:25:36 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#4] prototype.html Cycles:180 Average:5726.55 Median:6356.59 stddev:1587.17 (25.0%) stddev-sans-first:1543.35 16:25:36 INFO - PID 3922 | Values: 551.0 578.4 582.4 586.4 590.4 6350.0 6365.5 6368.6 6376.1 6428.6 6265.9 6306.9 6344.9 6363.2 6411.6 5189.5 5201.3 5216.8 5217.2 5244.9 4994.2 5199.8 5214.5 5260.0 5261.3 4977.6 4995.3 4996.8 5021.7 5032.5 5029.2 5041.8 5043.5 5056.9 5058.1 4565.4 4568.6 4590.6 4600.8 4631.6 6149.2 6201.7 6245.9 6334.9 6382.1 5954.7 6011.6 6018.7 6030.9 6049.4 6711.7 6752.5 6755.3 6797.0 6846.8 5127.7 5153.0 5160.7 5180.7 5195.0 6749.9 6858.5 6985.0 6994.7 7054.5 5232.3 5262.7 5304.0 5356.8 5386.5 5380.5 5434.3 5434.8 5435.3 5455.6 6017.3 6022.6 6038.6 6044.0 6045.8 6757.9 6808.8 6820.8 6835.5 6874.8 1845.7 1849.0 1857.8 1862.5 1865.9 1283.5 1351.3 1352.6 1353.4 1359.3 6272.8 6283.7 6287.2 6288.6 6304.5 6755.4 6789.3 6870.7 6875.5 6886.8 6290.2 6304.7 6334.6 6398.2 6400.2 3544.3 3588.7 3590.5 3604.5 3626.7 6992.4 7152.7 7155.9 7218.0 7223.0 7020.5 7027.9 7034.0 7035.9 7144.7 6964.9 7007.3 7053.9 7085.4 7157.2 6754.5 6769.8 6781.3 6827.8 6857.0 6723.3 6725.7 6761.0 6769.7 6853.1 6929.2 7025.6 7033.5 7041.3 7051.2 5232.0 5280.3 5317.1 5320.9 5357.3 6658.3 6861.3 6879.7 6889.8 6914.6 6530.6 6633.4 6634.7 6670.2 6737.9 6559.0 6582.5 6688.0 6714.0 6759.7 6380.8 6481.0 6514.5 6585.7 6619.7 6514.7 6518.5 6584.8 6640.8 6700.5 6404.2 6430.3 6445.3 6458.2 6492.3 16:25:36 INFO - PID 3922 | 16:25:36 INFO - PID 3922 | [#5] yui.html Cycles:180 Average:30046.41 Median:18797.67 stddev:46480.53 (247.3%) stddev-sans-first:46559.47 16:25:36 INFO - PID 3922 | Values: 920.7 957.1 994.5 1009.0 1014.3 19000.1 19403.0 19406.3 19461.3 23898.0 21064.6 21199.4 21209.8 21232.4 21254.4 1010.4 1012.0 1012.1 1012.4 1045.7 1049.4 1078.3 1085.8 1085.8 1088.1 1132.8 1133.0 1140.5 1141.7 1143.0 1113.9 1124.3 1124.6 1127.0 1127.3 830.7 831.6 836.7 837.3 837.7 20179.3 20859.7 21011.4 21015.4 21342.1 21034.2 22228.0 22624.4 22640.3 22649.7 18732.2 19070.8 19076.8 19166.3 19287.2 4048.3 4048.3 4088.4 4092.7 4092.9 170772.0 172385.0 172798.0 175087.0 175302.0 18609.8 18692.3 18733.9 18861.4 18973.6 33474.8 33587.3 34248.3 34302.0 34342.7 8395.0 8505.0 8546.9 8593.7 8607.7 3915.6 4027.5 4152.7 4263.7 4275.9 5930.8 6042.9 6043.4 6057.0 6060.6 1231.2 1252.9 1255.3 1265.6 1272.5 709.7 714.9 715.4 715.7 735.4 12685.0 13108.5 13165.5 13278.8 13498.0 678.9 687.6 692.7 705.3 711.4 5827.8 5842.7 5845.4 5924.7 6021.2 157721.0 161442.0 161586.0 164181.0 166312.0 146386.0 146561.0 148641.0 148995.0 151512.2 123300.0 124175.0 124384.0 125444.0 126937.4 11555.7 11632.9 11768.0 11883.8 11925.0 61472.0 61509.7 62161.7 63246.4 63375.4 74576.3 75813.0 76989.0 77719.6 78434.0 16657.2 16789.0 16789.0 16922.2 17000.6 19060.3 19159.3 19170.9 19277.4 19377.8 18019.2 18236.7 18256.5 18439.7 18452.6 17378.0 17396.6 17421.6 17474.3 17582.2 17042.1 17364.7 17412.7 17415.2 17607.6 12027.9 12254.9 12397.9 12524.2 12579.9 13473.8 13529.6 13557.7 13628.0 13629.8 16:25:36 INFO - PID 3922 | -------- Summary: end -------- 16:25:36 INFO - PID 3922 | 16:25:36 INFO - TEST-INFO | 3922: exit 0 16:25:36 INFO - TEST-OK | dromaeo_css | took 1109678ms 16:25:36 INFO - TEST-START | kraken 16:25:36 INFO - Initialising browser for kraken test... 16:25:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38851/getInfo.html -profile /tmp/tmpFO54eI/profile 16:25:36 INFO - TEST-INFO | started process 4337 (/builds/slave/test/build/application/firefox/firefox http://localhost:38851/getInfo.html) 16:25:42 INFO - TEST-INFO | 4337: exit 0 16:25:42 INFO - Browser initialized. 16:25:42 INFO - Running cycle 1/1 for kraken test... 16:25:42 INFO - Using env: {'DISPLAY': ':0', 16:25:42 INFO - 'HOME': '/home/cltbld', 16:25:42 INFO - 'JSGC_DISABLE_POISONING': '1', 16:25:42 INFO - 'LANG': 'en_US.UTF-8', 16:25:42 INFO - 'LANGUAGE': 'en_US:en', 16:25:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:25:42 INFO - 'LOGNAME': 'cltbld', 16:25:42 INFO - 'MAIL': '/var/mail/cltbld', 16:25:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:42 INFO - 'MOZ_CRASHREPORTER': '1', 16:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:25:42 INFO - 'MOZ_NO_REMOTE': '1', 16:25:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:42 INFO - 'NO_EM_RESTART': '1', 16:25:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:42 INFO - 'PWD': '/builds/slave/test', 16:25:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:42 INFO - 'RUST_BACKTRACE': 'full', 16:25:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:42 INFO - 'SHELL': '/bin/bash', 16:25:42 INFO - 'SHLVL': '1', 16:25:42 INFO - 'STYLO_FORCE_DISABLED': '1', 16:25:42 INFO - 'TERM': 'linux', 16:25:42 INFO - 'TMOUT': '86400', 16:25:42 INFO - 'USER': 'cltbld', 16:25:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1507071515.817658-771847013', 16:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:42 INFO - '_': '/tools/buildbot/bin/python'} 16:25:42 INFO - TEST-INFO | started process 4611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFO54eI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:42 INFO - PID 4611 | 16:25:42 INFO - PID 4611 | (/builds/slave/test/build/application/firefox/firefox:4660): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:25:42 INFO - PID 4611 | 16:25:53 INFO - PID 4611 | RSS: Main: 146038784 16:25:53 INFO - PID 4611 | 16:25:55 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:56 INFO - PID 4611 | RSS: Main: 151863296 16:25:56 INFO - PID 4611 | 16:25:59 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-dft) 16:25:59 INFO - PID 4611 | RSS: Main: 151375872 16:25:59 INFO - PID 4611 | 16:26:02 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-fft) 16:26:03 INFO - PID 4611 | RSS: Main: 148803584 16:26:03 INFO - PID 4611 | 16:26:05 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38851/tests/kraken/driver.html?testName=audio-oscillator) 16:26:06 INFO - PID 4611 | RSS: Main: 149028864 16:26:06 INFO - PID 4611 | 16:26:08 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:08 INFO - PID 4611 | RSS: Main: 148512768 16:26:08 INFO - PID 4611 | 16:26:11 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:12 INFO - PID 4611 | RSS: Main: 149364736 16:26:12 INFO - PID 4611 | 16:26:15 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38851/tests/kraken/driver.html?testName=imaging-desaturate) 16:26:16 INFO - PID 4611 | RSS: Main: 150347776 16:26:16 INFO - PID 4611 | 16:26:19 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38851/tests/kraken/driver.html?testName=json-parse-financial) 16:26:19 INFO - PID 4611 | RSS: Main: 151777280 16:26:19 INFO - PID 4611 | 16:26:21 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:26:22 INFO - PID 4611 | RSS: Main: 151367680 16:26:22 INFO - PID 4611 | 16:26:23 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:24 INFO - PID 4611 | RSS: Main: 151433216 16:26:24 INFO - PID 4611 | 16:26:26 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:26:26 INFO - PID 4611 | RSS: Main: 148545536 16:26:26 INFO - PID 4611 | 16:26:29 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:26:29 INFO - PID 4611 | RSS: Main: 148357120 16:26:29 INFO - PID 4611 | 16:26:32 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:33 INFO - PID 4611 | RSS: Main: 148783104 16:26:33 INFO - PID 4611 | 16:26:34 INFO - PID 4611 | Cycle 1(1): loaded http://localhost:38851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38851/tests/kraken/driver.html?testName=ai-astar) 16:26:35 INFO - PID 4611 | RSS: Main: 150536192 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | __start_tp_report 16:26:35 INFO - PID 4611 | _x_x_mozilla_page_load 16:26:35 INFO - PID 4611 | _x_x_mozilla_page_load_details 16:26:35 INFO - PID 4611 | |i|pagename|runs| 16:26:35 INFO - PID 4611 | |0;ai-astar;106;105;105;105;105;107;107;105;104;106 16:26:35 INFO - PID 4611 | |1;audio-beat-detection;112;113;113;112;142;113;112;112;116;113 16:26:35 INFO - PID 4611 | |2;audio-dft;161;162;164;161;162;162;162;163;163;168 16:26:35 INFO - PID 4611 | |3;audio-fft;74;77;73;75;76;72;73;75;74;74 16:26:35 INFO - PID 4611 | |4;audio-oscillator;78;78;77;78;77;79;78;77;78;125 16:26:35 INFO - PID 4611 | |5;imaging-gaussian-blur;114;113;113;114;113;114;114;113;115;115 16:26:35 INFO - PID 4611 | |6;imaging-darkroom;152;150;152;149;149;150;152;152;151;153 16:26:35 INFO - PID 4611 | |7;imaging-desaturate;94;96;94;94;94;95;94;99;95;95 16:26:35 INFO - PID 4611 | |8;json-parse-financial;44;45;45;43;49;45;43;44;44;43 16:26:35 INFO - PID 4611 | |9;json-stringify-tinderbox;40;40;40;39;39;39;40;40;40;40 16:26:35 INFO - PID 4611 | |10;stanford-crypto-aes;69;69;67;67;73;69;68;68;69;68 16:26:35 INFO - PID 4611 | |11;stanford-crypto-ccm;109;104;100;105;103;108;104;107;103;105 16:26:35 INFO - PID 4611 | |12;stanford-crypto-pbkdf2;150;147;144;149;152;153;149;145;150;146 16:26:35 INFO - PID 4611 | |13;stanford-crypto-sha256-iterative;64;55;57;60;57;60;56;57;59;58 16:26:35 INFO - PID 4611 | __end_tp_report 16:26:35 INFO - PID 4611 | __start_cc_report 16:26:35 INFO - PID 4611 | _x_x_mozilla_cycle_collect,738 16:26:35 INFO - PID 4611 | __end_cc_report 16:26:35 INFO - PID 4611 | __startTimestamp1507073195024__endTimestamp 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | ------- Summary: start ------- 16:26:35 INFO - PID 4611 | Number of tests: 14 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#0] ai-astar Cycles:10 Average:105.50 Median:105.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 16:26:35 INFO - PID 4611 | Values: 106.0 105.0 105.0 105.0 105.0 107.0 107.0 105.0 104.0 106.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:113.00 stddev:9.28 (8.2%) stddev-sans-first:9.74 16:26:35 INFO - PID 4611 | Values: 112.0 113.0 113.0 112.0 142.0 113.0 112.0 112.0 116.0 113.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.04 (1.3%) stddev-sans-first:2.06 16:26:35 INFO - PID 4611 | Values: 161.0 162.0 164.0 161.0 162.0 162.0 162.0 163.0 163.0 168.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.50 stddev:1.49 (2.0%) stddev-sans-first:1.58 16:26:35 INFO - PID 4611 | Values: 74.0 77.0 73.0 75.0 76.0 72.0 73.0 75.0 74.0 74.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:78.00 stddev:14.95 (19.2%) stddev-sans-first:15.76 16:26:35 INFO - PID 4611 | Values: 78.0 78.0 77.0 78.0 77.0 79.0 78.0 77.0 78.0 125.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:26:35 INFO - PID 4611 | Values: 114.0 113.0 113.0 114.0 113.0 114.0 114.0 113.0 115.0 115.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:152.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 16:26:35 INFO - PID 4611 | Values: 152.0 150.0 152.0 149.0 149.0 150.0 152.0 152.0 151.0 153.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.56 (1.6%) stddev-sans-first:1.62 16:26:35 INFO - PID 4611 | Values: 94.0 96.0 94.0 94.0 94.0 95.0 94.0 99.0 95.0 95.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#8] json-parse-financial Cycles:10 Average:44.50 Median:44.50 stddev:1.78 (4.0%) stddev-sans-first:1.88 16:26:35 INFO - PID 4611 | Values: 44.0 45.0 45.0 43.0 49.0 45.0 43.0 44.0 44.0 43.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#9] json-stringify-tinderbox Cycles:10 Average:39.70 Median:40.00 stddev:0.48 (1.2%) stddev-sans-first:0.50 16:26:35 INFO - PID 4611 | Values: 40.0 40.0 40.0 39.0 39.0 39.0 40.0 40.0 40.0 40.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#10] stanford-crypto-aes Cycles:10 Average:68.70 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 16:26:35 INFO - PID 4611 | Values: 69.0 69.0 67.0 67.0 73.0 69.0 68.0 68.0 69.0 68.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#11] stanford-crypto-ccm Cycles:10 Average:104.80 Median:105.00 stddev:2.66 (2.5%) stddev-sans-first:2.35 16:26:35 INFO - PID 4611 | Values: 109.0 104.0 100.0 105.0 103.0 108.0 104.0 107.0 103.0 105.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:149.50 stddev:2.95 (2.0%) stddev-sans-first:3.08 16:26:35 INFO - PID 4611 | Values: 150.0 147.0 144.0 149.0 152.0 153.0 149.0 145.0 150.0 146.0 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.30 Median:58.50 stddev:2.58 (4.4%) stddev-sans-first:1.73 16:26:35 INFO - PID 4611 | Values: 64.0 55.0 57.0 60.0 57.0 60.0 56.0 57.0 59.0 58.0 16:26:35 INFO - PID 4611 | -------- Summary: end -------- 16:26:35 INFO - PID 4611 | 16:26:35 INFO - PID 4611 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:26:35 INFO - TEST-INFO | 4611: exit 0 16:26:35 INFO - TEST-OK | kraken | took 59173ms 16:26:35 INFO - SUITE-END | took 1168s 16:26:35 INFO - Completed test suite (00:19:28) 16:26:35 INFO - javascript benchmark 16:26:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9121.665723646689, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3855.997440665426, 3860.478835357226, 3872.1674839909415, 3874.225154969007, 3874.7481413708124, 6188.195534580509, 6231.22109736283, 6265.809496195725, 6309.589876658019, 6344.365563443647, 6261.530385221104, 6274.686265686721, 6285.277193122793, 6301.275353334357, 6301.905471417932, 5582.86042848928, 5618.438156184389, 5631.042722737124, 5640.576956728261, 5648.915266271009, 5632.943670563303, 5706.914396284059, 5732.0828667413225, 5747.252857128588, 5752.1084231943905, 5692.9146062809095, 5708.571857110713, 5727.312722473288, 5734.311882574097, 5774.018416869121, 5511.58663100265, 5637.3235211774845, 5722.59941804076, 5796.82609521715, 5797.391273916221, 5302.734863256822, 5555.083411237141, 5602.0, 5629.915551266734, 5697.430256974311, 6282.937170628326, 6297.527685423612, 6301.6534090625, 6344.619322840645, 6362.141110950009, 6782.966085169543, 6831.9658401707675, 6865.0732151159955, 6903.620300883449, 6951.93048069523, 6930.30696930308, 6946.6179360135175, 6961.686724097377, 6969.47728920328, 6973.476989225828, 6306.085617585471, 6315.147455093595, 6340.112384266206, 6407.135036770023, 6416.903746443761, 6855.314468553105, 7037.859242815115, 7046.964765176142, 7127.679254433563, 7129.607871567114, 6734.932650673529, 6742.157230346207, 6816.488763342769, 6843.315668433117, 6856.451483881277, 6856.074429951992, 6858.759943401957, 6928.861422771617, 6940.0, 6991.23096459389, 6793.966030169916, 6808.489363297773, 6808.557443766139, 6894.310568943066, 6906.482013848981, 6836.145481814773, 6856.074429951992, 6919.550229235084, 6922.965385173042, 6927.792166235021, 5075.0357432087785, 5093.0577843099145, 5097.158968770112, 5103.030424219386, 5109.846704598868, 4496.775161241925, 4499.635204955221, 4541.909161816745, 4567.2920697291975, 4572.611328037154, 6198.349173336825, 6267.749290028348, 6276.184096067482, 6276.686165691697, 6278.717457714414, 6821.045053692487, 6832.0, 6833.077534532775, 6834.692438840264, 6836.760713375008, 6147.354527774609, 6155.938440615626, 6163.445289923929, 6171.413715697002, 6177.722002509898, 5462.399136095027, 5482.725863706799, 5546.473085056913, 5558.861028474321, 5577.581681373832, 6898.620575868375, 7002.124734408199, 7123.501354905211, 7126.821829454305, 7249.347558719741, 6899.448044156355, 6909.654517274217, 6911.654417279216, 6930.341617546325, 6938.098047253825, 7062.293770623102, 7085.681144348414, 7141.714331426685, 7153.177384600629, 7165.462590305644, 6779.389854913082, 6783.93216067833, 6847.760328388483, 6870.20992585859, 6872.41584465306, 6738.0, 6788.728450862108, 6869.931300686929, 6871.931280687129, 6879.3120687930805, 6648.401643851883, 6700.664966751546, 6706.497012723968, 6709.7651582194385, 6711.731530738911, 6567.146270984741, 6607.603543787388, 6614.801555953329, 6692.966535167293, 6714.462842972648, 6535.0, 6535.5425120241125, 6585.3085426029575, 6629.436497897733, 6640.867182656417, 6598.868022639616, 6615.6030638161865, 6679.966600166968, 6736.5958042517605, 6758.5269031167345, 6438.356164383524, 6480.57876238043, 6498.187726534184, 6508.186476690414, 6509.218893732593], "value": 6250.896178289051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.3873446689023, 976.858355538447, 1007.496251874063, 1008.5108722269698, 1010.0606436014508, 46187.30719039213, 46862.0, 46972.0, 46982.060358792805, 46991.530084699145, 44465.0, 44582.777086114525, 44651.1069778605, 44731.105377892505, 44819.32771008438, 7755.302022817959, 7834.843303133934, 7862.135165131831, 7862.135165131831, 7874.291313781759, 7804.3756499479905, 7852.921470785276, 7869.331106855924, 7869.449138560303, 7881.05427348719, 8342.791430214233, 8463.788405289886, 8471.915280847204, 8483.915160848404, 8485.915140848574, 8366.790830229233, 8412.36907231957, 8422.199891010345, 8423.663053477883, 8425.662973481054, 8259.545724985124, 8396.748097557083, 8408.159184081544, 8408.663653453854, 8413.032501262373, 41610.167796643895, 41618.79190604058, 41748.37377439341, 41916.1616767666, 42182.156356873, 3487.1805125795418, 3525.8765943191866, 3526.929461410783, 3528.6471352864764, 3530.5233793437815, 33323.0, 33341.666583334096, 33383.83308083444, 33456.665433345595, 33636.83181584101, 5549.306336707911, 5551.084071128259, 5559.777608895639, 5605.7197140142825, 5624.21261023457, 215894.92052539793, 216514.0, 216695.0, 216707.0, 216757.0, 48987.0, 49408.50591494111, 49518.0, 49547.0, 50781.0, 51395.48604513907, 51465.22802157971, 51649.741751291, 51754.48245517497, 51874.0, 15527.76708349353, 15634.140122293384, 15661.138637375054, 15676.843231567766, 15695.764563531557, 12155.331456769962, 12176.208546444454, 12243.142979991315, 12281.754364912831, 12284.324362159989, 16103.758443623356, 16138.515844524683, 16165.757513637305, 16167.272472738756, 16218.675626487404, 6282.780102696383, 6341.619502829845, 6368.872622547616, 6400.135981642418, 6458.354164583504, 1068.556549032143, 1083.5124194112682, 1088.2599832114238, 1100.4222783038967, 1103.426218366445, 26158.476830463285, 26223.73776262251, 26308.342291442485, 26473.205803825917, 26612.60081098785, 1187.4181650990952, 1189.2448295332526, 1208.2750349790056, 1220.7375414285793, 1225.2770865189582, 13811.861881381259, 13816.309184540733, 13914.234717090454, 13928.651783705489, 14094.224817635128, 279229.0, 281825.0, 281954.0, 282093.0, 282885.0, 60859.39140608626, 61067.0, 61433.38566614366, 61458.69270653618, 61726.0, 1517.4233791159509, 1523.428714232163, 1566.9138197399025, 1581.0710932662134, 1590.6023494126468, 25578.0, 25601.74398256068, 25602.103926362488, 25680.61479077778, 25878.741212587633, 43575.12849743051, 43727.34408983804, 43790.0, 43857.56142438535, 43920.34119488274, 247014.0, 247411.0, 260735.0, 264813.0, 265804.0, 35377.1155721109, 36177.105831532885, 39514.20971580495, 39740.40389394104, 40205.1958960825, 51294.74352628213, 51945.22082168846, 52047.73976130095, 52231.0, 52779.73610131925, 38179.80910095432, 38373.424398633484, 38391.0, 38543.0, 38560.80719596384, 37991.43012854864, 38046.61953380542, 38048.80975595215, 38113.80943095267, 38341.23317533689, 43419.0, 44343.77828110839, 44863.55136448594, 44904.550954491344, 44916.326255106855, 36418.63581364152, 36578.8171059143, 36749.0, 36784.63215367812, 36972.26055478929, 27239.59140612932, 27465.45069098647, 27627.30931726723, 27729.861350693925, 27936.0], "value": 19010.8148816907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.2154883751813, 633.0270816297082, 634.0841971162199, 645.0219425272688, 647.3678992762962, 23318.88340558299, 24284.150054748086, 24402.511949761018, 24445.87777061112, 24448.266552003424, 25436.491270174585, 26358.077467288647, 26399.3400164996, 26413.075542356022, 26799.732002680015, 6843.8973415398805, 7018.298170182992, 7025.754098606524, 7026.262242464544, 7029.0, 6487.578307410027, 6719.428848547879, 6733.225679046924, 6855.108835851357, 6917.308269173092, 6707.932920670804, 6714.362135597111, 6715.395614394703, 6715.764948226813, 6721.663916804165, 6635.469162466991, 6673.199216094051, 6711.798646040626, 6717.697703603325, 6717.832054198635, 6224.719887605069, 6235.657038862861, 6243.313235544132, 6265.8120256392385, 6276.843078923018, 26825.0, 27403.45193096127, 28100.297492562848, 28288.15135545937, 28512.0, 2305.4005958450757, 2339.415146213447, 2358.1157066100213, 2364.219807463533, 2367.5028244068767, 19859.50351241216, 20922.37232883016, 21776.346709598736, 21822.890885545472, 21865.0, 2585.909493167749, 2588.184721812623, 2633.9604905926235, 2651.5549025780997, 2666.213467027212, 162542.1872890628, 166213.0, 174811.0, 182371.0, 183897.0, 15360.923195383952, 16326.673466530603, 16398.0, 16493.752593711102, 16627.584310392336, 25304.493910122063, 25535.74464255371, 25586.872065639553, 25589.0, 25625.10312139066, 10153.847692284622, 10612.20408469368, 10673.146148308117, 10835.404052777016, 10868.184886133571, 9620.90379096214, 9629.229661627052, 9748.463834489172, 9932.155766759906, 9950.502474876228, 9205.76985575366, 9513.857292140623, 9566.0, 9593.952030239805, 9659.855102173473, 2884.7259510346903, 2888.653361596622, 2892.9276768080967, 3099.1560021787, 3114.7819652624553, 1033.7415646088477, 1064.797688439194, 1073.1951036722458, 1076.5747529725716, 1078.5577913055608, 21627.24304649361, 21909.452263693536, 22023.0, 22050.11799528033, 22175.66736498954, 1123.1407972900738, 1131.7057565033151, 1134.8638163420442, 1135.2110283353156, 1144.2390810111183, 11747.353895535827, 11990.940045299718, 12136.393180341125, 12154.696132596579, 12216.450259738333, 622607.0, 632596.0, 634823.0, 642415.0, 648781.0, 122378.38810805889, 122859.0, 123904.38047809704, 124393.0, 126573.0, 1246.719488115185, 1254.9623511294676, 1284.0305569295308, 1288.2592509307185, 1291.1930043722673, 19327.8067219326, 19409.51476213106, 19449.902750486723, 19471.026448677225, 19679.0, 61395.69302153461, 62446.06330905131, 62501.0, 63323.6833815828, 64424.0, 77153.61423192848, 77803.0, 77914.22085779297, 78908.0, 78912.21087789048, 15236.162011089496, 15286.617834554225, 15342.15618141013, 15376.84623153799, 15377.769333459783, 22840.657390139495, 22884.771152288264, 22949.770502294763, 23012.07951681981, 23077.961491732578, 18495.167717453016, 18592.628147437244, 18799.06004699732, 19102.33141840029, 19111.139998699815, 16523.917380413022, 16761.91619041897, 17047.8918870278, 17176.484705458857, 17301.13494325304, 18049.278028878696, 19201.0, 19356.0, 19461.51346216299, 19468.415947521597, 15107.39570417171, 15110.093394396372, 15119.395224191348, 15154.393824246907, 15176.089434633957, 18338.26646934161, 18400.53998649991, 18649.720254195927, 18715.625687486445, 18909.810901890804], "value": 12821.841756681688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.9872801271988, 1308.9934550327248, 1315.375196781529, 1315.4803852478271, 1317.9670508237286, 16883.57791055224, 18181.999999999967, 18195.54511137219, 18247.908760456197, 18297.817021829793, 17863.10684465778, 18148.455546333596, 18152.0, 18156.63686726265, 18194.63610727788, 2691.3944362518473, 2710.7018227994904, 2742.1362270884706, 2748.4365705030423, 2751.0, 2428.9271321860374, 2502.5245203411387, 2541.8601976891264, 2542.1102614085016, 2545.4272788622598, 2592.41670624109, 2617.9214623561325, 2660.1088635307196, 2661.9068332608363, 2662.960055599158, 2440.1825388494785, 2482.2677310193535, 2483.1309041835393, 2489.153687746175, 2499.212747984388, 2397.1969390254285, 2410.3130607776698, 2410.6384042393606, 2414.9637755433682, 2416.7099948006176, 16295.429659961845, 16438.095904725236, 16504.25730842115, 16508.0, 16553.337866485326, 8094.473859199192, 8305.044919834176, 8314.085450600429, 8340.249377555989, 8356.0, 5499.835004949858, 5678.4605462480995, 5754.223179870705, 5804.042333015047, 5827.533797296206, 2177.6624623183434, 2199.8790066546335, 2202.4383782135615, 2203.2398822406403, 2255.8984845681985, 30913.072607821803, 30958.690413096032, 31051.37897242065, 31270.687293127005, 31279.218019549466, 7131.429485641136, 7209.279072092749, 7247.565146091251, 7370.262973702587, 7383.187849336568, 19262.80737192638, 19390.224391024483, 19396.0, 19409.902950485157, 19440.611187776165, 8292.958535207406, 8513.19124683154, 8528.147185281547, 8546.700865469804, 8583.914160858312, 7604.961975190088, 7727.690892364355, 7759.57322347265, 7761.573113478813, 7772.533647981139, 5903.409659034062, 5957.702114894238, 5987.0, 5989.221401217814, 6128.662923539248, 1693.4665580342153, 1711.880168388201, 1742.4075814222972, 1760.7270873014447, 1770.2564922732483, 930.1070971866948, 937.2595649436869, 941.8634298026885, 946.7254496196026, 950.9429434233969, 8238.794030149294, 8294.626741796634, 8302.252797248157, 8364.749057528285, 8376.162383761697, 737.6643627149634, 751.5190278221943, 756.3797685897512, 761.5697131120899, 762.3024932187097, 5634.267545219177, 5734.655920644775, 5771.538276937835, 5776.624519406225, 5841.357450680422, 25012.124575639766, 25674.229773106836, 26008.609870851953, 26218.606720899203, 26284.605730914052, 24630.876845615658, 25211.74788252094, 25224.74775252224, 25254.116105936573, 25570.360740981254, 11781.823272650918, 11842.703932401759, 12153.5138594457, 12173.573924912585, 12457.563985260653, 9099.954500227457, 9162.816743665222, 9167.358284919992, 9184.954075229582, 9185.908140918506, 20612.278570249968, 21030.47423814417, 21313.89343053275, 21592.67610985868, 21784.782152178275, 22018.339449816533, 22102.00540975628, 22313.665295020914, 22331.10675572959, 22367.77632223722, 12228.633141005785, 12250.754984900073, 12325.445354958869, 12388.752224955631, 12471.563495277622, 15732.292046858147, 15771.369145234063, 15801.68396632084, 15916.920415397848, 15942.362305508113, 12649.177803443115, 12663.303518306582, 12804.679883002627, 12813.423395947018, 12925.676858078623, 11686.065114790967, 11788.0, 11901.0, 12021.278723276631, 12126.151169418055, 11210.0, 11453.828192576952, 11476.483558239732, 11485.425728713699, 11488.770224595628, 7779.844403111792, 7999.280064794197, 8070.0, 8117.918820811717, 8214.671413143407, 8076.87884681742, 8099.109097999333, 8100.432969692065, 8197.180281971756, 8230.21812927771], "value": 7162.794767977468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9696966666834, 578.3869098755322, 582.3623132669725, 586.4135864135864, 590.4243362721346, 6349.968250158743, 6365.52258580606, 6368.649724265169, 6376.107344971701, 6428.550001499897, 6265.874682506347, 6306.873862522747, 6344.873102537958, 6363.204599425072, 6411.551191416591, 5189.455107213745, 5201.271821944931, 5216.76524556394, 5217.191335343009, 5244.947550524484, 4994.200927851544, 5199.792008319662, 5214.530692237698, 5260.0, 5261.289725887013, 4977.601791856643, 4995.275685025669, 4996.800127994894, 5021.6986980781085, 5032.540563236657, 5029.164355010432, 5041.773120209563, 5043.470435604282, 5056.898862022776, 5058.114829904752, 4565.406497155382, 4568.634509239253, 4590.563896429834, 4600.815967361302, 4631.560001799858, 6149.2313460817395, 6201.658908760016, 6245.937540624581, 6334.87330253397, 6382.1384113144595, 5954.732037058299, 6011.639301641915, 6018.6689732064715, 6030.879382412327, 6049.396909818902, 6711.731530738764, 6752.493562982747, 6755.256921738604, 6796.966015169942, 6846.828829279308, 5127.692638248346, 5152.974235128838, 5160.664556803796, 5180.740962951837, 5195.0, 6749.865002699968, 6858.51990360675, 6984.965075174642, 6994.68523916425, 7054.5061845670825, 5232.319798426181, 5262.736863156827, 5303.973480132575, 5356.7589458473685, 5386.5152136307925, 5380.515753582196, 5434.3207099112615, 5434.777175135563, 5435.320584926884, 5455.645383050169, 6017.308009578955, 6022.638641681513, 6038.607490513103, 6043.969780151071, 6045.818625441244, 6757.932420675828, 6808.761693340709, 6820.795376138723, 6835.453163746888, 6874.828129296808, 1845.7231415287815, 1848.9630207395776, 1857.786354569242, 1862.4785060183171, 1865.9253629854925, 1283.5186804948144, 1351.2770667692737, 1352.6280272925023, 1353.4315587453293, 1359.3475131936527, 6272.8118156455375, 6283.6858157091965, 6287.208145678551, 6288.5598008139905, 6304.495640348761, 6755.392014718699, 6789.25318214996, 6870.656467176621, 6875.518713689994, 6886.827829304308, 6290.182276304143, 6304.716287767062, 6334.588251763621, 6398.168238129014, 6400.167978162809, 3544.326577950181, 3588.659077387644, 3590.4793804898145, 3604.459331100356, 3626.7461277710836, 6992.370686638125, 7152.749653762094, 7155.92844071563, 7217.9639101805205, 7222.96388518054, 7020.543664661781, 7027.89458158128, 7034.0, 7035.929640703527, 7144.678489467987, 6964.930350696428, 7007.334303241082, 7053.929460705327, 7085.441202935346, 7157.24848890859, 6754.493412994143, 6769.849125648553, 6781.254062053072, 6827.829304267433, 6856.965715171592, 6723.327667233238, 6725.663716814238, 6760.966195168992, 6769.729210831709, 6853.143357080365, 6929.237783843672, 7025.648717564203, 7033.542819716702, 7041.3310735480045, 7051.153861536648, 5231.973840130775, 5280.313559237275, 5317.075608415279, 5320.920186197132, 5357.303550538405, 6658.267590565131, 6861.250381152774, 6879.6560171992205, 6889.827754305982, 6914.55055421396, 6530.608163510205, 6633.402993730588, 6634.734610615521, 6670.232923213698, 6737.9326206737305, 6558.967205163944, 6582.539222254396, 6687.966560167362, 6714.0, 6759.695813688494, 6380.776672816429, 6481.0, 6514.54398192122, 6585.715785421989, 6619.735210591522, 6514.706838192198, 6518.478521718346, 6584.76953306632, 6640.83397915056, 6700.46396288286, 6404.231492220777, 6430.324815894263, 6445.291017987924, 6458.22501299847, 6492.253390859923], "value": 5272.833958472356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [920.6869664314136, 957.1242313283346, 994.5077186792537, 1008.9607704064814, 1014.3406785589361, 19000.144993475293, 19403.0, 19406.320778772744, 19461.318853840137, 23898.0, 21064.578708425823, 21199.364019079454, 21209.787902120974, 21232.363029109114, 21254.362369128914, 1010.3786171504545, 1012.0436187802529, 1012.0891197921856, 1012.3622118065608, 1045.7333379988092, 1049.4385503755493, 1078.3152698036763, 1085.793699197154, 1085.8262677971527, 1088.1186239146316, 1132.8357388178708, 1133.0142775785077, 1140.4696815980567, 1141.6746227325214, 1143.0284258380352, 1113.883042280561, 1124.2579897267765, 1124.550179928027, 1126.9774604507904, 1127.334872425269, 830.6760363458257, 831.6465502161557, 836.6695155413638, 837.3134030095324, 837.6691206973211, 20179.293724719566, 20859.687104693443, 21011.36965891026, 21015.369538913856, 21342.146314147416, 21034.158633654635, 22228.0, 22624.434389140402, 22640.320790376314, 22649.660255096187, 18732.15705293265, 19070.809291907182, 19076.809231907642, 19166.329178478685, 19287.22851085955, 4048.251073551373, 4048.271311163989, 4088.366303223005, 4092.6725861930972, 4092.9181416371803, 170772.0, 172385.0, 172798.0, 175087.0, 175302.0, 18609.81390186081, 18692.252309907723, 18733.906330468533, 18861.434156975312, 18973.620527589646, 33474.832625836716, 33587.328253435284, 34248.31503369919, 34302.0, 34342.65657343445, 8394.958025209957, 8504.957475212708, 8546.871796923051, 8593.742187734379, 8607.698730544525, 3915.5888631693833, 4027.496562929634, 4152.709310348307, 4263.701540892108, 4275.893102672458, 5930.7924222652, 6042.909356359658, 6043.365446628129, 6057.000594901792, 6060.636361818305, 1231.1812644591425, 1252.8997680185564, 1255.2593969558004, 1265.5950095969201, 1272.5291642092484, 709.7303024850523, 714.8570285942832, 715.3811952660911, 715.713714514188, 735.4300417176731, 12685.0, 13108.50938321735, 13165.53920612774, 13278.800817987738, 13498.0, 678.8506528563709, 687.5874475314871, 692.7367600311849, 705.3369832357567, 711.3988679565758, 5827.79602713903, 5842.669678283338, 5845.41545845412, 5924.7333869975955, 6021.187139736079, 157721.0, 161442.0, 161586.0, 164181.0, 166312.0, 146386.0, 146561.0, 148641.0, 148995.0, 151512.2424387893, 123300.0, 124175.0, 124384.0, 125444.0, 126937.36531317285, 11555.71110722205, 11632.88367116318, 11768.0, 11883.82174267404, 11925.0459963201, 61472.0, 61509.692451537456, 62161.689191553756, 63246.36753632405, 63375.36624633695, 74576.25423745693, 75813.0, 76989.0, 77719.61140194263, 78434.0, 16657.167141642625, 16789.0, 16789.0, 16922.15389230558, 17000.57498562546, 19060.332888348843, 19159.329423470113, 19170.90414547974, 19277.421677349703, 19377.8062219376, 18019.189136489153, 18236.726449103007, 18256.543586410447, 18439.72340414868, 18452.630947381247, 17377.957322560687, 17396.565085872953, 17421.564460888578, 17474.30102795925, 17582.20880060375, 17042.147892605073, 17364.73952890733, 17412.738808917624, 17415.21631526559, 17607.647847043245, 12027.939860300643, 12254.938725306672, 12397.93801030989, 12524.248545087325, 12579.93710031444, 13473.797893031808, 13529.59411217665, 13557.661058473617, 13628.0, 13629.795553066513], "value": 10009.167960443805, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 105.0, 105.0, 105.0, 107.0, 107.0, 105.0, 104.0, 106.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 142.0, 113.0, 112.0, 112.0, 116.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 161.0, 162.0, 162.0, 162.0, 163.0, 163.0, 168.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 73.0, 75.0, 76.0, 72.0, 73.0, 75.0, 74.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 78.0, 77.0, 79.0, 78.0, 77.0, 78.0, 125.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 149.0, 149.0, 150.0, 152.0, 152.0, 151.0, 153.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 43.0, 49.0, 45.0, 43.0, 44.0, 44.0, 43.0], "value": 44.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 40.0, 40.0, 39.0, 39.0, 39.0, 40.0, 40.0, 40.0, 40.0], "value": 39.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 67.0, 73.0, 69.0, 68.0, 68.0, 69.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 100.0, 105.0, 103.0, 108.0, 104.0, 107.0, 103.0, 105.0], "value": 104.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 144.0, 149.0, 152.0, 153.0, 149.0, 145.0, 150.0, 146.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 55.0, 57.0, 60.0, 57.0, 60.0, 56.0, 57.0, 59.0, 58.0], "value": 58.3, "unit": "score"}]}]} 16:26:35 INFO - Return code: 0 16:26:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:35 INFO - # TBPL SUCCESS # 16:26:35 INFO - Running post-action listener: _package_coverage_data 16:26:35 INFO - Running post-action listener: _resource_record_post_action 16:26:35 INFO - [mozharness: 2017-10-03 23:26:35.839725Z] Finished run-tests step (success) 16:26:35 INFO - Running post-run listener: _resource_record_post_run 16:26:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 9371648; Write bytes: 313602048; Read time: 2636; Write time: 249852 16:26:35 INFO - TinderboxPrint: CPU usage
13.1% 16:26:35 INFO - TinderboxPrint: I/O read bytes / time
9,371,648 / 2,636 16:26:35 INFO - TinderboxPrint: I/O write bytes / time
313,602,048 / 249,852 16:26:35 INFO - TinderboxPrint: CPU idle
8,224.3 (86.9%) 16:26:35 INFO - TinderboxPrint: CPU user
1,187.6 (12.5%) 16:26:35 INFO - TinderboxPrint: Swap in / out
0 / 0 16:26:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 3444736; Read time: 0; Write time: 192 16:26:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:26:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 9367552; Write bytes: 242720768; Read time: 2480; Write time: 207224 16:26:36 INFO - Running post-run listener: _upload_blobber_files 16:26:36 INFO - Blob upload gear active. 16:26:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:36 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 16:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:26:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:37 INFO - (blobuploader) - INFO - Done attempting. 16:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:38 INFO - (blobuploader) - INFO - Done attempting. 16:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:39 INFO - (blobuploader) - INFO - Done attempting. 16:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:47 INFO - (blobuploader) - INFO - Done attempting. 16:26:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:47 INFO - Return code: 0 16:26:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73cd7cb483b1a40897bd53f755765d41a3e64647ec079526ee8447bbb777a0f6f29f9b5c0d742f4a9ba1743739ead11f89d81eeb64888267620a8e77a9a63e60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c3f2c6cc164c034defcd158f0852a351835e5b9587cd3f498e8d837491abf9f27eeb1c2cb171c6a4bd4f0803140528dadc2be256368517e6202885155a13fbc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7706b8a4b44392e3d6b9b57f66263030fe54771b2f98465a16eb0f94c34867ebbe783da3e41f34f9ec6c5d54cb3e7ea742fb24bab5e3a2a4b267417113caeb54", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2817bad32d6c0793bfcc9fc1e90ca70538803622c76076c971dd09d80be11abefcb756657ea9c5520b48121aaceab2b43a9a5f7fbaf6d3ce901b0e71809e8a2d"} 16:26:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:47 INFO - Contents: 16:26:47 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73cd7cb483b1a40897bd53f755765d41a3e64647ec079526ee8447bbb777a0f6f29f9b5c0d742f4a9ba1743739ead11f89d81eeb64888267620a8e77a9a63e60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c3f2c6cc164c034defcd158f0852a351835e5b9587cd3f498e8d837491abf9f27eeb1c2cb171c6a4bd4f0803140528dadc2be256368517e6202885155a13fbc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7706b8a4b44392e3d6b9b57f66263030fe54771b2f98465a16eb0f94c34867ebbe783da3e41f34f9ec6c5d54cb3e7ea742fb24bab5e3a2a4b267417113caeb54", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2817bad32d6c0793bfcc9fc1e90ca70538803622c76076c971dd09d80be11abefcb756657ea9c5520b48121aaceab2b43a9a5f7fbaf6d3ce901b0e71809e8a2d"} 16:26:47 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:47 INFO - Copying logs to upload dir... 16:26:47 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.716949 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-10-03 16:26:47.320389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 16:26:47.326391) ========= 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-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73cd7cb483b1a40897bd53f755765d41a3e64647ec079526ee8447bbb777a0f6f29f9b5c0d742f4a9ba1743739ead11f89d81eeb64888267620a8e77a9a63e60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c3f2c6cc164c034defcd158f0852a351835e5b9587cd3f498e8d837491abf9f27eeb1c2cb171c6a4bd4f0803140528dadc2be256368517e6202885155a13fbc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7706b8a4b44392e3d6b9b57f66263030fe54771b2f98465a16eb0f94c34867ebbe783da3e41f34f9ec6c5d54cb3e7ea742fb24bab5e3a2a4b267417113caeb54", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2817bad32d6c0793bfcc9fc1e90ca70538803622c76076c971dd09d80be11abefcb756657ea9c5520b48121aaceab2b43a9a5f7fbaf6d3ce901b0e71809e8a2d"} build_url:https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/Ffxf4E-mT86Y4EN0dsL5BA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73cd7cb483b1a40897bd53f755765d41a3e64647ec079526ee8447bbb777a0f6f29f9b5c0d742f4a9ba1743739ead11f89d81eeb64888267620a8e77a9a63e60", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c3f2c6cc164c034defcd158f0852a351835e5b9587cd3f498e8d837491abf9f27eeb1c2cb171c6a4bd4f0803140528dadc2be256368517e6202885155a13fbc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7706b8a4b44392e3d6b9b57f66263030fe54771b2f98465a16eb0f94c34867ebbe783da3e41f34f9ec6c5d54cb3e7ea742fb24bab5e3a2a4b267417113caeb54", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2817bad32d6c0793bfcc9fc1e90ca70538803622c76076c971dd09d80be11abefcb756657ea9c5520b48121aaceab2b43a9a5f7fbaf6d3ce901b0e71809e8a2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 16:26:47.357698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:26:47.358094) ========= 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-1507071515.817658-771847013 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 16:26:47.437847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 16:26:47.438166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 16:26:47.438454) ========= ========= Total master_lag: 0.23 =========