builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1504995673.78 results: success (0) revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.779364) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.779773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.780058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.797085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.797347) ========= 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=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 15:21:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2017-09-09 15:21:14 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168096 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.980727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:13.981053) ========= 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=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019180 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.034815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.037183) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 --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 d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 --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=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 15:21:14,258 truncating revision to first 12 chars 2017-09-09 15:21:14,258 Setting DEBUG logging. 2017-09-09 15:21:14,258 attempt 1/10 2017-09-09 15:21:14,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d53ba311ca2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 15:21:14,632 unpacking tar archive at: mozilla-central-d53ba311ca2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.723594) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.723892) ========= script_repo_revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.727278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.727541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:21:14.740650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-09 15:21:14.740926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:15 INFO - MultiFileLogger online at 20170909 15:21:15 in /builds/slave/test 15:21:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:21:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:15 INFO - {'append_to_log': False, 15:21:15 INFO - 'base_work_dir': '/builds/slave/test', 15:21:15 INFO - 'blob_upload_branch': 'Firefox', 15:21:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:15 INFO - 'branch': 'Firefox', 15:21:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:15 INFO - 'code_coverage': False, 15:21:15 INFO - 'config_files': ('talos/linux_config.py',), 15:21:15 INFO - 'default_actions': ('clobber', 15:21:15 INFO - 'read-buildbot-config', 15:21:15 INFO - 'download-and-extract', 15:21:15 INFO - 'populate-webroot', 15:21:15 INFO - 'create-virtualenv', 15:21:15 INFO - 'install', 15:21:15 INFO - 'setup-mitmproxy', 15:21:15 INFO - 'run-tests'), 15:21:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:15 INFO - 'disable_ccov_upload': False, 15:21:15 INFO - 'disable_stylo': False, 15:21:15 INFO - 'download_minidump_stackwalk': True, 15:21:15 INFO - 'download_symbols': 'ondemand', 15:21:15 INFO - 'enable_stylo': False, 15:21:15 INFO - 'enable_webrender': False, 15:21:15 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:21:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:15 INFO - 'gecko_profile': False, 15:21:15 INFO - 'gecko_profile_interval': 0, 15:21:15 INFO - 'installer_path': 'installer.exe', 15:21:15 INFO - 'log_level': 'info', 15:21:15 INFO - 'log_name': 'talos', 15:21:15 INFO - 'log_to_console': True, 15:21:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:15 INFO - 'opt_config_files': (), 15:21:15 INFO - 'pip_index': False, 15:21:15 INFO - 'suite': 'dromaeojs-e10s', 15:21:15 INFO - 'system_bits': '32', 15:21:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:15 INFO - 'title': 'talos-linux64-ix-032', 15:21:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:15 INFO - 'use_talos_json': True, 15:21:15 INFO - 'verify': 'False', 15:21:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:15 INFO - 'work_dir': 'build'} 15:21:15 INFO - [mozharness: 2017-09-09 22:21:15.114086Z] Running clobber step. 15:21:15 INFO - Running pre-action listener: _resource_record_pre_action 15:21:15 INFO - Running main action method: clobber 15:21:15 INFO - rmtree: /builds/slave/test/build 15:21:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:16 INFO - Running post-action listener: _resource_record_post_action 15:21:16 INFO - [mozharness: 2017-09-09 22:21:16.206296Z] Finished clobber step (success) 15:21:16 INFO - [mozharness: 2017-09-09 22:21:16.206396Z] Running read-buildbot-config step. 15:21:16 INFO - Running pre-action listener: _resource_record_pre_action 15:21:16 INFO - Running main action method: read_buildbot_config 15:21:16 INFO - Using buildbot properties: 15:21:16 INFO - { 15:21:16 INFO - "project": "", 15:21:16 INFO - "product": "firefox", 15:21:16 INFO - "who": "archaeopteryx@coole-files.de", 15:21:16 INFO - "installer_path": "public/build/target.tar.bz2", 15:21:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:21:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:21:16 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:21:16 INFO - "stage_platform": "linux64-qr", 15:21:16 INFO - "basedir": "/builds/slave/test", 15:21:16 INFO - "buildnumber": 42, 15:21:16 INFO - "platform": "ubuntu64_hw_qr", 15:21:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:21:16 INFO - "slavebuilddir": "test", 15:21:16 INFO - "taskId": "EGGXi_yASQqdQB4VmJmheA", 15:21:16 INFO - "branch": "mozilla-central", 15:21:16 INFO - "script_repo_revision": "production", 15:21:16 INFO - "revision": "d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6", 15:21:16 INFO - "slavename": "talos-linux64-ix-032", 15:21:16 INFO - "repo_path": "mozilla-central" 15:21:16 INFO - } 15:21:16 INFO - Finding installer, test and symbols from parent task. 15:21:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EGGXi_yASQqdQB4VmJmheA'}, attempt #1 15:21:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EGGXi_yASQqdQB4VmJmheA'}, attempt #1 15:21:17 INFO - Task dependencies: MA-3vqX9SCK7dglRp0vY9Q 15:21:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q'}, attempt #1 15:21:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:21:17 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json 15:21:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip 15:21:17 INFO - Running post-action listener: _resource_record_post_action 15:21:17 INFO - [mozharness: 2017-09-09 22:21:17.550879Z] Finished read-buildbot-config step (success) 15:21:17 INFO - [mozharness: 2017-09-09 22:21:17.551094Z] Running download-and-extract step. 15:21:17 INFO - Running pre-action listener: _resource_record_pre_action 15:21:17 INFO - Running main action method: download_and_extract 15:21:17 INFO - mkdir: /builds/slave/test/build/tests 15:21:17 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')]} 15:21:17 INFO - trying https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json 15:21:17 INFO - Downloading https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:21:18 INFO - Downloaded 989 bytes. 15:21:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:21:18 INFO - Using the following test package requirements: 15:21:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:21:18 INFO - u'common': [u'target.common.tests.zip'], 15:21:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:21:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:21:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:21:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:21:18 INFO - u'mozbase': [u'target.common.tests.zip'], 15:21:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:21:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:21:18 INFO - u'web-platform': [u'target.common.tests.zip', 15:21:18 INFO - u'target.web-platform.tests.tar.gz'], 15:21:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:21:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:21:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip 15:21:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:21:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.common.tests.zip into memory 15:21:19 INFO - Content-Length response header: 55024690 15:21:19 INFO - Bytes received: 55024690 15:21:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip 15:21:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:21:30 INFO - Fetch https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.talos.tests.zip into memory 15:21:30 INFO - Content-Length response header: 14497963 15:21:30 INFO - Bytes received: 14497963 15:21:31 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')]} 15:21:31 INFO - trying https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:21:31 INFO - Downloading https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:21:32 INFO - Downloaded 62936068 bytes. 15:21:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:21:32 INFO - mkdir: /builds/slave/test/properties 15:21:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:21:32 INFO - Writing to file /builds/slave/test/properties/build_url 15:21:32 INFO - Contents: 15:21:32 INFO - build_url:https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 15:21:32 INFO - Running post-action listener: _resource_record_post_action 15:21:32 INFO - Running post-action listener: find_tests_for_verification 15:21:32 INFO - Running post-action listener: set_extra_try_arguments 15:21:32 INFO - [mozharness: 2017-09-09 22:21:32.775380Z] Finished download-and-extract step (success) 15:21:32 INFO - [mozharness: 2017-09-09 22:21:32.775480Z] Running populate-webroot step. 15:21:32 INFO - Running pre-action listener: _resource_record_pre_action 15:21:32 INFO - Running main action method: populate_webroot 15:21:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:21:32 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['tresize', 15:21:32 INFO - 'tcanvasmark']}, 15:21:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:21:32 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['dromaeo_css', 15:21:32 INFO - 'kraken']}, 15:21:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:32 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'tests': ['damp', 'tps']}, 15:21:32 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['damp', 'tps']}, 15:21:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:32 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['dromaeo_dom']}, 15:21:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:21:32 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['basic_compositor_video', 15:21:32 INFO - 'glvideo']}, 15:21:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:21:32 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['ts_paint_webext', 15:21:32 INFO - 'tp5o_webext']}, 15:21:32 INFO - 'other-e10s': {'tests': ['a11yr', 15:21:32 INFO - 'ts_paint', 15:21:32 INFO - 'tpaint', 15:21:32 INFO - 'sessionrestore', 15:21:32 INFO - 'sessionrestore_many_windows', 15:21:32 INFO - 'sessionrestore_no_auto_restore', 15:21:32 INFO - 'tabpaint']}, 15:21:32 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['a11yr', 15:21:32 INFO - 'ts_paint', 15:21:32 INFO - 'tpaint', 15:21:32 INFO - 'sessionrestore', 15:21:32 INFO - 'sessionrestore_many_windows', 15:21:32 INFO - 'sessionrestore_no_auto_restore', 15:21:32 INFO - 'tabpaint']}, 15:21:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:21:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:21:32 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['bloom_basic_singleton']}, 15:21:32 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['bloom_basic']}, 15:21:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:21:32 INFO - 'tsvgr_opacity', 15:21:32 INFO - 'tart', 15:21:32 INFO - 'tscrollx', 15:21:32 INFO - 'tsvg_static']}, 15:21:32 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['tsvgx', 15:21:32 INFO - 'tsvgr_opacity', 15:21:32 INFO - 'tart', 15:21:32 INFO - 'tscrollx', 15:21:32 INFO - 'tsvg_static']}, 15:21:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:21:32 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo'], 15:21:32 INFO - 'tests': ['tp5o']}, 15:21:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:21:32 INFO - 'talos_options': ['--mitmproxy', 15:21:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:21:32 INFO - '--firstNonBlankPaint'], 15:21:32 INFO - 'tests': ['tp6_google', 15:21:32 INFO - 'tp6_youtube', 15:21:32 INFO - 'tp6_amazon', 15:21:32 INFO - 'tp6_facebook']}, 15:21:32 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo', 15:21:32 INFO - '--mitmproxy', 15:21:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:21:32 INFO - '--firstNonBlankPaint'], 15:21:32 INFO - 'tests': ['tp6_google', 15:21:32 INFO - 'tp6_youtube', 15:21:32 INFO - 'tp6_amazon', 15:21:32 INFO - 'tp6_facebook']}, 15:21:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:21:32 INFO - 'talos_options': ['--stylo-threads=1', 15:21:32 INFO - '--mitmproxy', 15:21:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:21:32 INFO - '--firstNonBlankPaint'], 15:21:32 INFO - 'tests': ['tp6_google', 15:21:32 INFO - 'tp6_youtube', 15:21:32 INFO - 'tp6_amazon', 15:21:32 INFO - 'tp6_facebook']}, 15:21:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--xperf_path', 15:21:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:32 INFO - 'tests': ['tp5n']}, 15:21:32 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:21:32 INFO - 'talos_options': ['--disable-stylo', 15:21:32 INFO - '--xperf_path', 15:21:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:32 INFO - 'tests': ['tp5n']}}} 15:21:32 INFO - Running post-action listener: _resource_record_post_action 15:21:32 INFO - [mozharness: 2017-09-09 22:21:32.792952Z] Finished populate-webroot step (success) 15:21:32 INFO - [mozharness: 2017-09-09 22:21:32.793041Z] Running create-virtualenv step. 15:21:32 INFO - Running pre-action listener: _resource_record_pre_action 15:21:32 INFO - Running main action method: create_virtualenv 15:21:32 INFO - Creating virtualenv /builds/slave/test/build/venv 15:21:32 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:21:32 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:21:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:21:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:21:33 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:33 INFO - Installing pip...............done. 15:21:33 INFO - Return code: 0 15:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:21:33 INFO - Reading from file tmpfile_stdout 15:21:33 INFO - Output received: 15:21:33 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:21:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21: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')]} 15:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21: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', 'pip>=1.5'] in /builds/slave/test/build 15:21: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 pip>=1.5 15:21:33 INFO - Using env: {'DISPLAY': ':0', 15:21:33 INFO - 'HOME': '/home/cltbld', 15:21:33 INFO - 'LANG': 'en_US.UTF-8', 15:21:33 INFO - 'LANGUAGE': 'en_US:en', 15:21:33 INFO - 'LOGNAME': 'cltbld', 15:21:33 INFO - 'MAIL': '/var/mail/cltbld', 15:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:33 INFO - 'MOZ_NO_REMOTE': '1', 15:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:33 INFO - 'NO_EM_RESTART': '1', 15:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:33 INFO - 'PWD': '/builds/slave/test', 15:21:33 INFO - 'SHELL': '/bin/bash', 15:21:33 INFO - 'SHLVL': '1', 15:21:33 INFO - 'TERM': 'linux', 15:21:33 INFO - 'TMOUT': '86400', 15:21:33 INFO - 'USER': 'cltbld', 15:21:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:33 INFO - '_': '/tools/buildbot/bin/python'} 15:21:34 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:21:34 INFO - Downloading/unpacking pip>=1.5 15:21:34 INFO - Running setup.py egg_info for package pip 15:21:34 INFO - warning: no files found matching 'pip/cacert.pem' 15:21:34 INFO - warning: no files found matching '*.html' under directory 'docs' 15:21:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:21:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:21:34 INFO - Installing collected packages: pip 15:21:34 INFO - Found existing installation: pip 1.1 15:21:34 INFO - Uninstalling pip: 15:21:34 INFO - Successfully uninstalled pip 15:21:34 INFO - Running setup.py install for pip 15:21:34 INFO - warning: no files found matching 'pip/cacert.pem' 15:21:34 INFO - warning: no files found matching '*.html' under directory 'docs' 15:21:34 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:21:34 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:21:34 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:21:34 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:21:34 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:21:34 INFO - Successfully installed pip 15:21:34 INFO - Cleaning up... 15:21:35 INFO - Return code: 0 15:21:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:21:35 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')]} 15:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:35 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')]} 15:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:35 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:35 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 15:21:35 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 15:21:35 INFO - Using env: {'DISPLAY': ':0', 15:21:35 INFO - 'HOME': '/home/cltbld', 15:21:35 INFO - 'LANG': 'en_US.UTF-8', 15:21:35 INFO - 'LANGUAGE': 'en_US:en', 15:21:35 INFO - 'LOGNAME': 'cltbld', 15:21:35 INFO - 'MAIL': '/var/mail/cltbld', 15:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:35 INFO - 'MOZ_NO_REMOTE': '1', 15:21:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:35 INFO - 'NO_EM_RESTART': '1', 15:21:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:35 INFO - 'PWD': '/builds/slave/test', 15:21:35 INFO - 'SHELL': '/bin/bash', 15:21:35 INFO - 'SHLVL': '1', 15:21:35 INFO - 'TERM': 'linux', 15:21:35 INFO - 'TMOUT': '86400', 15:21:35 INFO - 'USER': 'cltbld', 15:21:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:35 INFO - '_': '/tools/buildbot/bin/python'} 15:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:35 INFO - Downloading/unpacking psutil>=3.1.1 15:21: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 15:21: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 15:21: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 15:21: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 15:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:36 INFO - Installing collected packages: psutil 15:21:36 INFO - Running setup.py install for psutil 15:21:36 INFO - building 'psutil._psutil_linux' extension 15:21:36 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 15:21:36 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 15:21:36 INFO - building 'psutil._psutil_posix' extension 15:21:36 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 15:21:36 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 15:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:36 INFO - Successfully installed psutil 15:21:36 INFO - Cleaning up... 15:21:37 INFO - Return code: 0 15:21:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:37 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:37 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 15:21:37 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 15:21:37 INFO - Using env: {'DISPLAY': ':0', 15:21:37 INFO - 'HOME': '/home/cltbld', 15:21:37 INFO - 'LANG': 'en_US.UTF-8', 15:21:37 INFO - 'LANGUAGE': 'en_US:en', 15:21:37 INFO - 'LOGNAME': 'cltbld', 15:21:37 INFO - 'MAIL': '/var/mail/cltbld', 15:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:37 INFO - 'MOZ_NO_REMOTE': '1', 15:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:37 INFO - 'NO_EM_RESTART': '1', 15:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:37 INFO - 'PWD': '/builds/slave/test', 15:21:37 INFO - 'SHELL': '/bin/bash', 15:21:37 INFO - 'SHLVL': '1', 15:21:37 INFO - 'TERM': 'linux', 15:21:37 INFO - 'TMOUT': '86400', 15:21:37 INFO - 'USER': 'cltbld', 15:21:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:37 INFO - '_': '/tools/buildbot/bin/python'} 15:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:21: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 15:21: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 15:21: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 15:21: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 15:21:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:21:38 INFO - Installing collected packages: mozsystemmonitor 15:21:38 INFO - Running setup.py install for mozsystemmonitor 15:21:38 INFO - Successfully installed mozsystemmonitor 15:21:38 INFO - Cleaning up... 15:21:39 INFO - Return code: 0 15:21:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21: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')]} 15:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:21:39 INFO - Using env: {'DISPLAY': ':0', 15:21:39 INFO - 'HOME': '/home/cltbld', 15:21:39 INFO - 'LANG': 'en_US.UTF-8', 15:21:39 INFO - 'LANGUAGE': 'en_US:en', 15:21:39 INFO - 'LOGNAME': 'cltbld', 15:21:39 INFO - 'MAIL': '/var/mail/cltbld', 15:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:39 INFO - 'MOZ_NO_REMOTE': '1', 15:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:39 INFO - 'NO_EM_RESTART': '1', 15:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:39 INFO - 'PWD': '/builds/slave/test', 15:21:39 INFO - 'SHELL': '/bin/bash', 15:21:39 INFO - 'SHLVL': '1', 15:21:39 INFO - 'TERM': 'linux', 15:21:39 INFO - 'TMOUT': '86400', 15:21:39 INFO - 'USER': 'cltbld', 15:21:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:39 INFO - '_': '/tools/buildbot/bin/python'} 15:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:40 INFO - Downloading/unpacking jsonschema==2.5.1 15:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:21:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:21:42 INFO - warning: no files found matching '*.txt' 15:21:42 INFO - no previously-included directories found matching 'build' 15:21:42 INFO - no previously-included directories found matching 'dist' 15:21:42 INFO - no previously-included directories found matching '.git*' 15:21:42 INFO - Installing collected packages: jsonschema, functools32 15:21:43 INFO - Running setup.py install for functools32 15:21:43 INFO - warning: no files found matching '*.txt' 15:21:43 INFO - no previously-included directories found matching 'build' 15:21:43 INFO - no previously-included directories found matching 'dist' 15:21:43 INFO - no previously-included directories found matching '.git*' 15:21:43 INFO - Successfully installed jsonschema functools32 15:21:43 INFO - Cleaning up... 15:21:43 INFO - Return code: 0 15:21:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:21:43 INFO - Using env: {'DISPLAY': ':0', 15:21:43 INFO - 'HOME': '/home/cltbld', 15:21:43 INFO - 'LANG': 'en_US.UTF-8', 15:21:43 INFO - 'LANGUAGE': 'en_US:en', 15:21:43 INFO - 'LOGNAME': 'cltbld', 15:21:43 INFO - 'MAIL': '/var/mail/cltbld', 15:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:43 INFO - 'MOZ_NO_REMOTE': '1', 15:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:43 INFO - 'NO_EM_RESTART': '1', 15:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:43 INFO - 'PWD': '/builds/slave/test', 15:21:43 INFO - 'SHELL': '/bin/bash', 15:21:43 INFO - 'SHLVL': '1', 15:21:43 INFO - 'TERM': 'linux', 15:21:43 INFO - 'TMOUT': '86400', 15:21:43 INFO - 'USER': 'cltbld', 15:21:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:43 INFO - '_': '/tools/buildbot/bin/python'} 15:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:21:43 INFO - Cleaning up... 15:21:43 INFO - Return code: 0 15:21:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:21:43 INFO - Using env: {'DISPLAY': ':0', 15:21:43 INFO - 'HOME': '/home/cltbld', 15:21:43 INFO - 'LANG': 'en_US.UTF-8', 15:21:43 INFO - 'LANGUAGE': 'en_US:en', 15:21:43 INFO - 'LOGNAME': 'cltbld', 15:21:43 INFO - 'MAIL': '/var/mail/cltbld', 15:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:43 INFO - 'MOZ_NO_REMOTE': '1', 15:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:43 INFO - 'NO_EM_RESTART': '1', 15:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:43 INFO - 'PWD': '/builds/slave/test', 15:21:43 INFO - 'SHELL': '/bin/bash', 15:21:43 INFO - 'SHLVL': '1', 15:21:43 INFO - 'TERM': 'linux', 15:21:43 INFO - 'TMOUT': '86400', 15:21:43 INFO - 'USER': 'cltbld', 15:21:43 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:43 INFO - '_': '/tools/buildbot/bin/python'} 15:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21: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 15:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21: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 15:21:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:21:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:21: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 15:21: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 15:21: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 15:21: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 15:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:21:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:21: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 15:21: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 15:21: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 15:21: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 15:21:45 INFO - Downloading docopt-0.6.1.tar.gz 15:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:21:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:21:45 INFO - Running setup.py install for blobuploader 15:21:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:21:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:21:45 INFO - Running setup.py install for requests 15:21:46 INFO - Running setup.py install for docopt 15:21:46 INFO - Successfully installed blobuploader requests docopt 15:21:46 INFO - Cleaning up... 15:21:46 INFO - Return code: 0 15:21:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:46 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:46 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 15:21:46 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 15:21:46 INFO - Using env: {'DISPLAY': ':0', 15:21:46 INFO - 'HOME': '/home/cltbld', 15:21:46 INFO - 'LANG': 'en_US.UTF-8', 15:21:46 INFO - 'LANGUAGE': 'en_US:en', 15:21:46 INFO - 'LOGNAME': 'cltbld', 15:21:46 INFO - 'MAIL': '/var/mail/cltbld', 15:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:46 INFO - 'MOZ_NO_REMOTE': '1', 15:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:46 INFO - 'NO_EM_RESTART': '1', 15:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:46 INFO - 'PWD': '/builds/slave/test', 15:21:46 INFO - 'SHELL': '/bin/bash', 15:21:46 INFO - 'SHLVL': '1', 15:21:46 INFO - 'TERM': 'linux', 15:21:46 INFO - 'TMOUT': '86400', 15:21:46 INFO - 'USER': 'cltbld', 15:21:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:46 INFO - '_': '/tools/buildbot/bin/python'} 15:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:46 INFO - Running setup.py (path:/tmp/pip-Apvb3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:46 INFO - Running setup.py (path:/tmp/pip-2c7BjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:46 INFO - Running setup.py (path:/tmp/pip-LEmkAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 INFO - Running setup.py (path:/tmp/pip-WoUaeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:46 INFO - Running setup.py (path:/tmp/pip-NmSBwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:46 INFO - Running setup.py (path:/tmp/pip-o7YPkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:47 INFO - Running setup.py (path:/tmp/pip-zoeWJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:47 INFO - Running setup.py (path:/tmp/pip-ct9TQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:47 INFO - Running setup.py (path:/tmp/pip-QS7AAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:47 INFO - Running setup.py (path:/tmp/pip-7kLXVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:47 INFO - Running setup.py (path:/tmp/pip-Geu1Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:47 INFO - Running setup.py (path:/tmp/pip-TYZG7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 INFO - Running setup.py (path:/tmp/pip-IhzPDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 INFO - Running setup.py (path:/tmp/pip-8xo75B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 INFO - Running setup.py (path:/tmp/pip-owLMbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:47 INFO - Running setup.py (path:/tmp/pip-RVqKDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:47 INFO - Running setup.py (path:/tmp/pip-iLFxlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:47 INFO - Running setup.py install for manifestparser 15:21:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:21:47 INFO - Running setup.py install for mozcrash 15:21:48 INFO - Running setup.py install for mozdebug 15:21:48 INFO - Running setup.py install for mozdevice 15:21:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for mozfile 15:21:48 INFO - Running setup.py install for mozhttpd 15:21:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for mozinfo 15:21:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for mozInstall 15:21:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for mozleak 15:21:48 INFO - Running setup.py install for mozlog 15:21:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for moznetwork 15:21:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:21:48 INFO - Running setup.py install for mozprocess 15:21:48 INFO - Running setup.py install for mozprofile 15:21:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:21:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:21:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:21:49 INFO - Running setup.py install for mozrunner 15:21:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:21:49 INFO - Running setup.py install for mozscreenshot 15:21:49 INFO - Running setup.py install for moztest 15:21:49 INFO - Running setup.py install for mozversion 15:21:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:21:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:49 INFO - Cleaning up... 15:21:49 INFO - Return code: 0 15:21:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:49 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:49 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 15:21:49 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 15:21:49 INFO - Using env: {'DISPLAY': ':0', 15:21:49 INFO - 'HOME': '/home/cltbld', 15:21:49 INFO - 'LANG': 'en_US.UTF-8', 15:21:49 INFO - 'LANGUAGE': 'en_US:en', 15:21:49 INFO - 'LOGNAME': 'cltbld', 15:21:49 INFO - 'MAIL': '/var/mail/cltbld', 15:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:49 INFO - 'MOZ_NO_REMOTE': '1', 15:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:49 INFO - 'NO_EM_RESTART': '1', 15:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:49 INFO - 'PWD': '/builds/slave/test', 15:21:49 INFO - 'SHELL': '/bin/bash', 15:21:49 INFO - 'SHLVL': '1', 15:21:49 INFO - 'TERM': 'linux', 15:21:49 INFO - 'TMOUT': '86400', 15:21:49 INFO - 'USER': 'cltbld', 15:21:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:49 INFO - '_': '/tools/buildbot/bin/python'} 15:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:49 INFO - Running setup.py (path:/tmp/pip-aKE9I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:49 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)) 15:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:49 INFO - Running setup.py (path:/tmp/pip-1zKbSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:49 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)) 15:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:49 INFO - Running setup.py (path:/tmp/pip-rTVBdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:49 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)) 15:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:49 INFO - Running setup.py (path:/tmp/pip-6ivnHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:50 INFO - Running setup.py (path:/tmp/pip-iCA9K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:50 INFO - Running setup.py (path:/tmp/pip-2i63Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:50 INFO - Running setup.py (path:/tmp/pip-yeZD4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:50 INFO - Running setup.py (path:/tmp/pip-s9bJrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:50 INFO - Running setup.py (path:/tmp/pip-KhtwXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:50 INFO - Running setup.py (path:/tmp/pip-hPUt4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:50 INFO - Running setup.py (path:/tmp/pip-HWdoVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:50 INFO - Running setup.py (path:/tmp/pip-yTPakI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:50 INFO - Running setup.py (path:/tmp/pip-KExvXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:50 INFO - Running setup.py (path:/tmp/pip-6q1mqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:50 INFO - Running setup.py (path:/tmp/pip-MMw0UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:50 INFO - Running setup.py (path:/tmp/pip-k0PGzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:50 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)) 15:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:50 INFO - Running setup.py (path:/tmp/pip-nLHqDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:51 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)) 15:21:51 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)) 15:21:51 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)) 15:21:51 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)) 15:21:51 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)) 15:21:51 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)) 15:21:51 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)) 15:21:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:21:51 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 15:21:51 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 15:21:51 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 15:21:51 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 15:21:52 INFO - Downloading blessings-1.6.tar.gz 15:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:52 INFO - Installing collected packages: blessings 15:21:52 INFO - Running setup.py install for blessings 15:21:52 INFO - Successfully installed blessings 15:21:52 INFO - Cleaning up... 15:21:52 INFO - Return code: 0 15:21:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:52 INFO - Reading from file tmpfile_stdout 15:21:52 INFO - Current package versions: 15:21:52 INFO - argparse == 1.2.1 15:21:52 INFO - blessings == 1.6 15:21:52 INFO - blobuploader == 1.2.4 15:21:52 INFO - docopt == 0.6.1 15:21:52 INFO - functools32 == 3.2.3-2 15:21:52 INFO - jsonschema == 2.5.1 15:21:52 INFO - manifestparser == 1.1 15:21:52 INFO - mozInstall == 1.13 15:21:52 INFO - mozcrash == 1.0 15:21:52 INFO - mozdebug == 0.1 15:21:52 INFO - mozdevice == 0.51 15:21:52 INFO - mozfile == 1.2 15:21:52 INFO - mozhttpd == 0.7 15:21:52 INFO - mozinfo == 0.10 15:21:52 INFO - mozleak == 0.1 15:21:52 INFO - mozlog == 3.5 15:21:52 INFO - moznetwork == 0.27 15:21:52 INFO - mozprocess == 0.25 15:21:52 INFO - mozprofile == 0.28 15:21:52 INFO - mozrunner == 6.13 15:21:52 INFO - mozscreenshot == 0.1 15:21:52 INFO - mozsystemmonitor == 0.3 15:21:52 INFO - moztest == 0.8 15:21:52 INFO - mozversion == 1.4 15:21:52 INFO - psutil == 3.1.1 15:21:52 INFO - requests == 1.2.3 15:21:52 INFO - wsgiref == 0.1.2 15:21:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:52 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:52 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 15:21:52 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 15:21:52 INFO - Using env: {'DISPLAY': ':0', 15:21:52 INFO - 'HOME': '/home/cltbld', 15:21:52 INFO - 'LANG': 'en_US.UTF-8', 15:21:52 INFO - 'LANGUAGE': 'en_US:en', 15:21:52 INFO - 'LOGNAME': 'cltbld', 15:21:52 INFO - 'MAIL': '/var/mail/cltbld', 15:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:52 INFO - 'MOZ_NO_REMOTE': '1', 15:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:52 INFO - 'NO_EM_RESTART': '1', 15:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:52 INFO - 'PWD': '/builds/slave/test', 15:21:52 INFO - 'SHELL': '/bin/bash', 15:21:52 INFO - 'SHLVL': '1', 15:21:52 INFO - 'TERM': 'linux', 15:21:52 INFO - 'TMOUT': '86400', 15:21:52 INFO - 'USER': 'cltbld', 15:21:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:52 INFO - '_': '/tools/buildbot/bin/python'} 15:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 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)) 15:21:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:21:52 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 15:21:52 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 15:21:52 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 15:21:52 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 15:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:21:53 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)) 15:21:53 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)) 15:21:53 INFO - Installing collected packages: simplejson 15:21:53 INFO - Running setup.py install for simplejson 15:21:54 INFO - building 'simplejson._speedups' extension 15:21:54 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 15:21:54 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 15:21:54 INFO - Successfully installed simplejson 15:21:54 INFO - Cleaning up... 15:21:54 INFO - Return code: 0 15:21:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:21:54 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')]} 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:54 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')]} 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:54 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 0x12441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, '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': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', '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 15:21:54 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 15:21:54 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 15:21:54 INFO - Using env: {'DISPLAY': ':0', 15:21:54 INFO - 'HOME': '/home/cltbld', 15:21:54 INFO - 'LANG': 'en_US.UTF-8', 15:21:54 INFO - 'LANGUAGE': 'en_US:en', 15:21:54 INFO - 'LOGNAME': 'cltbld', 15:21:54 INFO - 'MAIL': '/var/mail/cltbld', 15:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:54 INFO - 'MOZ_NO_REMOTE': '1', 15:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:54 INFO - 'NO_EM_RESTART': '1', 15:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:54 INFO - 'PWD': '/builds/slave/test', 15:21:54 INFO - 'SHELL': '/bin/bash', 15:21:54 INFO - 'SHLVL': '1', 15:21:54 INFO - 'TERM': 'linux', 15:21:54 INFO - 'TMOUT': '86400', 15:21:54 INFO - 'USER': 'cltbld', 15:21:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:54 INFO - '_': '/tools/buildbot/bin/python'} 15:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:21:55 INFO - Cleaning up... 15:21:55 INFO - Return code: 0 15:21:55 INFO - Running post-action listener: _resource_record_post_action 15:21:55 INFO - Running post-action listener: _start_resource_monitoring 15:21:55 INFO - Starting resource monitoring. 15:21:55 INFO - [mozharness: 2017-09-09 22:21:55.242477Z] Finished create-virtualenv step (success) 15:21:55 INFO - [mozharness: 2017-09-09 22:21:55.242996Z] Running install step. 15:21:55 INFO - Running pre-action listener: _resource_record_pre_action 15:21:55 INFO - Running main action method: install 15:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:55 INFO - Reading from file tmpfile_stdout 15:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:21:55 INFO - Reading from file tmpfile_stdout 15:21:55 INFO - Output received: 15:21:55 INFO - Usage: mozinstall [options] installer 15:21:55 INFO - Options: 15:21:55 INFO - -h, --help show this help message and exit 15:21:55 INFO - -d DEST, --destination=DEST 15:21:55 INFO - Directory to install application into. [default: 15:21:55 INFO - "/builds/slave/test"] 15:21:55 INFO - --app=APP Application being installed. [default: firefox] 15:21:55 INFO - mkdir: /builds/slave/test/build/application 15:21:55 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'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:22:12 INFO - Reading from file tmpfile_stdout 15:22:12 INFO - Output received: 15:22:12 INFO - /builds/slave/test/build/application/firefox/firefox 15:22:12 INFO - Running post-action listener: _resource_record_post_action 15:22:12 INFO - [mozharness: 2017-09-09 22:22:12.159756Z] Finished install step (success) 15:22:12 INFO - [mozharness: 2017-09-09 22:22:12.159903Z] Running setup-mitmproxy step. 15:22:12 INFO - Running pre-action listener: _resource_record_pre_action 15:22:12 INFO - Running main action method: setup_mitmproxy 15:22:12 INFO - Skipping: mitmproxy is not required 15:22:12 INFO - Running post-action listener: _resource_record_post_action 15:22:12 INFO - [mozharness: 2017-09-09 22:22:12.160434Z] Finished setup-mitmproxy step (success) 15:22:12 INFO - [mozharness: 2017-09-09 22:22:12.160534Z] Running run-tests step. 15:22:12 INFO - Running pre-action listener: _resource_record_pre_action 15:22:12 INFO - Running pre-action listener: _set_gcov_prefix 15:22:12 INFO - Running main action method: run_tests 15:22:12 WARNING - Try message not found. 15:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:12 INFO - Python 2.7.3 15:22:12 INFO - Return code: 0 15:22:12 INFO - grabbing minidump binary from tooltool 15:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:12 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 0x15b4090>, '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 0x15b4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15aef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:12 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 15:22:12 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 15:22:12 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 15:22:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:12 INFO - Return code: 0 15:22:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:22:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:12 INFO - ENV: RUST_BACKTRACE is now full 15:22:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:22:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:22:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:22:12 INFO - Using env: {'DISPLAY': ':0', 15:22:12 INFO - 'HOME': '/home/cltbld', 15:22:12 INFO - 'LANG': 'en_US.UTF-8', 15:22:12 INFO - 'LANGUAGE': 'en_US:en', 15:22:12 INFO - 'LOGNAME': 'cltbld', 15:22:12 INFO - 'MAIL': '/var/mail/cltbld', 15:22:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:12 INFO - 'MOZ_ACCELERATED': '1', 15:22:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:12 INFO - 'MOZ_NO_REMOTE': '1', 15:22:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:12 INFO - 'MOZ_WEBRENDER': '1', 15:22:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:12 INFO - 'NO_EM_RESTART': '1', 15:22:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:12 INFO - 'PWD': '/builds/slave/test', 15:22:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:12 INFO - 'RUST_BACKTRACE': 'full', 15:22:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:22:12 INFO - 'SHELL': '/bin/bash', 15:22:12 INFO - 'SHLVL': '1', 15:22:12 INFO - 'TERM': 'linux', 15:22:12 INFO - 'TMOUT': '86400', 15:22:12 INFO - 'USER': 'cltbld', 15:22:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:22:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:12 INFO - '_': '/tools/buildbot/bin/python'} 15:22:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:22:12 INFO - mozversion application_buildid: 20170909213208 15:22:12 INFO - mozversion application_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:22:12 INFO - mozversion application_display_name: Nightly 15:22:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:12 INFO - mozversion application_name: Firefox 15:22:12 INFO - mozversion application_remotingname: firefox 15:22:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:22:12 INFO - mozversion application_vendor: Mozilla 15:22:12 INFO - mozversion application_version: 57.0a1 15:22:12 INFO - mozversion platform_buildid: 20170909213208 15:22:12 INFO - mozversion platform_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:22:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:22:12 INFO - mozversion platform_version: 57.0a1 15:22:12 INFO - using testdate: 1504995732 15:22:12 INFO - actual date: 1504995732 15:22:12 INFO - starting webserver on 'localhost:56596' 15:22:12 INFO - SUITE-START | Running 2 tests 15:22:12 INFO - TEST-START | dromaeo_css 15:22:12 INFO - Initialising browser for dromaeo_css test... 15:22:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56596/getInfo.html -profile /tmp/tmppDPocG/profile 15:22:12 INFO - TEST-INFO | started process 9432 (/builds/slave/test/build/application/firefox/firefox http://localhost:56596/getInfo.html) 15:22:18 INFO - TEST-INFO | 9432: exit 0 15:22:18 INFO - Browser initialized. 15:22:18 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:18 INFO - Using env: {'DISPLAY': ':0', 15:22:18 INFO - 'HOME': '/home/cltbld', 15:22:18 INFO - 'JSGC_DISABLE_POISONING': '1', 15:22:18 INFO - 'LANG': 'en_US.UTF-8', 15:22:18 INFO - 'LANGUAGE': 'en_US:en', 15:22:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:22:18 INFO - 'LOGNAME': 'cltbld', 15:22:18 INFO - 'MAIL': '/var/mail/cltbld', 15:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:18 INFO - 'MOZ_ACCELERATED': '1', 15:22:18 INFO - 'MOZ_CRASHREPORTER': '1', 15:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:22:18 INFO - 'MOZ_NO_REMOTE': '1', 15:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:18 INFO - 'MOZ_WEBRENDER': '1', 15:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:18 INFO - 'NO_EM_RESTART': '1', 15:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:18 INFO - 'PWD': '/builds/slave/test', 15:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:18 INFO - 'RUST_BACKTRACE': 'full', 15:22:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:22:18 INFO - 'SHELL': '/bin/bash', 15:22:18 INFO - 'SHLVL': '1', 15:22:18 INFO - 'TERM': 'linux', 15:22:18 INFO - 'TMOUT': '86400', 15:22:18 INFO - 'USER': 'cltbld', 15:22:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:18 INFO - '_': '/tools/buildbot/bin/python'} 15:22:18 INFO - TEST-INFO | started process 9637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppDPocG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:19 INFO - PID 9637 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:22:19 INFO - PID 9637 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:22:20 INFO - PID 9637 | 15:22:20 INFO - PID 9637 | (/builds/slave/test/build/application/firefox/firefox:9698): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:22:20 INFO - PID 9637 | 15:22:30 INFO - PID 9637 | RSS: Main: 211988480 15:22:30 INFO - PID 9637 | 15:25:27 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56596/tests/dromaeo/cssquery-ext.html) 15:25:28 INFO - PID 9637 | RSS: Main: 216858624 15:25:28 INFO - PID 9637 | 15:28:31 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-ext.html (next: http://localhost:56596/tests/dromaeo/cssquery-jquery.html) 15:28:31 INFO - PID 9637 | RSS: Main: 216637440 15:28:31 INFO - PID 9637 | 15:31:33 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56596/tests/dromaeo/cssquery-mootools.html) 15:31:34 INFO - PID 9637 | RSS: Main: 222445568 15:31:34 INFO - PID 9637 | 15:34:36 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56596/tests/dromaeo/cssquery-prototype.html) 15:34:37 INFO - PID 9637 | RSS: Main: 217956352 15:34:37 INFO - PID 9637 | 15:37:40 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56596/tests/dromaeo/cssquery-yui.html) 15:37:41 INFO - PID 9637 | RSS: Main: 219824128 15:37:41 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | Cycle 1(1): loaded http://localhost:56596/tests/dromaeo/cssquery-yui.html (next: http://localhost:56596/tests/dromaeo/cssquery-dojo.html) 15:40:43 INFO - PID 9637 | RSS: Main: 221917184 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | __start_tp_report 15:40:43 INFO - PID 9637 | _x_x_mozilla_page_load 15:40:43 INFO - PID 9637 | _x_x_mozilla_page_load_details 15:40:43 INFO - PID 9637 | |i|pagename|runs| 15:40:43 INFO - PID 9637 | |0;dojo.html;3065.203047207726;3085.95371069434;3088.3668847886183;3091.1962889648685;3124.7031532004453;6023.548233882465;6158.507319414442;6215.12988181655;6234.127222188898;6262.248530176374;6119.7246123924415;6132.632042077478;6145.846353841156;6166.105914642374;6192.72132754026;5676.943230567704;5688.459596338352;5737;5759.654420734749;5812.302523697141;5624.831255062334;5647.37878833328;5677.602567820254;5685.147227915804;5781.421857814227;973.9173687319302;5696.658200507962;5835.766569337221;5844.152597873306;5876.7355469004;5274.657147285453;5625.268715067056;5664.235328230678;5705.400932902027;5818.44724751148;5639.887202255973;5691.117876729114;5757.424257574251;5762.510186634141;5775.5957083004205;6208.5033197344555;6223.5954662947215;6232.9065064023625;6259.812205633838;6287.339829317902;6624.171978502687;6628.635425051621;6679.465642748569;6696.330366963313;6739;6421;6674.566153200027;6752.291009444036;6753.763618273386;6822;6067.666278354689;6080.2399700037495;6081.209442772411;6125.5712100153005;6194.163787888668;6810.421114205348;6897.896531552031;6924.307569243036;6931.826704332432;7029.61337126463;6639.966800166065;6690.832729181712;6707.396334329934;6715.630640314829;6722.327767223239;6659.134312539339;6659.167604049494;6661.733530658719;6716.832079197961;6753.223379311344;6417.422431981144;6525.836854078591;6555.868882622321;6572.80281591553;6587;6550.639714815731;6556.508261880378;6619.966900165565;6628.138342015507;6641.070250164981;5162.767675454614;5200.6879587224885;5206.167013277857;5251.868703282448;5258.474152584788;4596.195665758479;4646.09401166776;4646.117237724821;4653.464851542049;4655.4180727409075;5670.8015219467125;5672.659640421588;5709.68596727184;5721.828345149652;5770.711464426762;6412.7114279857515;6556.311587283267;6579.78274019308;6611.173603299588;6673.132492775908;5653.745581448845;5710.8001219957105;5760.193572899798;5765.509931655773;5781.219535362757;5695.60130790849;5792.88414231713;5799.3620701722775;5811.215485909348;5819.563532735062;6437.549371544041;6444.484441244689;6549.901751473732;6564.606123632598;6566.080748695186;6438.742450301936;6660.733570657313;6681.599104053772;6748.089007983859;6757.189137303555;6284.088807123033;6427.357264273723;6495.837604059936;6500.317466666121;6512.413882750575;6549.279579246184;6599.373059559334;6602.372774586406;6645.468362531083;6661.134052573135;6731.461483081243;6815.454763618799;6820.488463365168;6825.658717064226;6828.317168283132;6471.514636402383;6481.805545833632;6484.962406015015;6552.017197420425;6577.14497115372;6292.622442653455;6364.93635063662;6447.387498187664;6543.051257567721;6544.705488252945;6295.370462953668;6354.205724284465;6402.6158430494315;6410.230772307166;6411.326810684997;6549.6070235786;6564.737410503526;6596.208454985433;6606.339366063356;6639.7012134455035;6259.96870015647;6261.405166509175;6339.873202535831;6344.555881088279;6345.428911397997 15:40:43 INFO - PID 9637 | |1;ext.html;799.1409235072297;834.3908946469078;840.6217202258981;840.8066144786695;841.970531031414;37874.24251514968;41621.58378416215;41735;41756.58243417565;41805.9548511287;38024.429633555446;38134.23731525375;38243;38434.61565384345;38629.61370386295;6997.475189360793;7045.225025247219;7135.036770036057;7763.689452421896;7922.326602238817;7749.496282741632;7815.726449574266;7817.530948143101;7819.726309579166;7845.490043147206;7801.063872335328;7835.764927052198;7848.843023139534;7853.939718138064;7862.921370786276;7757.224277572254;7767.53394796314;7772.067351917778;7779.3776497880035;7820.76537703867;7719.459637825355;7756.146823849372;7780.649870755773;7785.026871641045;7809.843803123963;37636.435453467944;37868.62131378678;38004;38016.23967520662;38115.80942095272;3486.8256587170795;3521.295740851814;3525.11872031992;3525.2773181497987;3526.964730352715;30856.228594285098;30979.380412391627;31104.844475777703;31119.37761244785;31166;5186.403563590197;5266.605004624668;5296.841094767125;5301.840944771663;5314.229436731691;185768;185770;186216;186644;186769;40917;41760.58239417567;47617.285740713916;47649.52350476451;47994;51183.488165118615;51230.48769512332;52182.47817521852;52188.47811521912;52337.21494177591;15278.15970121654;15321.387144514094;15326.080435173924;15328.156951367782;15333.769993450107;12464.376781160905;12524.937375313066;12563.434645440977;12573.811392829115;12610.180338277982;14069.437222510986;14263.286835658175;14341.64145896361;14395.78406323906;14531.709365812625;5696.943030569641;5725.541956643458;5730.455606717355;5750.942490575125;5782.3639399666;990.2820455170088;1009.7021378693303;1021.8211812932707;1037.9429131397694;1041.578160844844;22526.21158259453;22735.09059637629;22862.885685571797;23141.652875206884;23256.53486930252;1104.7845670094255;1124.4658787076073;1126.7859106769852;1128.373752567333;1132.3206076354122;11961.222520536137;12055.336956467478;12101.697457563456;12237.265764054186;12242.81635775464;214776;215362;215741;215769;217228;52817.73591132097;53429.1985620216;53446.19830702543;53457.1981420279;53540.196897046575;1441.6467965348347;1454.9127052376891;1463.6633574277976;1470.154661069889;1497.91012539248;22319.665205022262;22432.775672243068;22550.097996079974;22746.43133921665;22964.885175574684;37666.24667506689;37910.62089379071;37985;38027.61972380352;38042.23915521729;195825;197453;197561;197807;197931;30621.08136755901;30882.53676194814;33288.50067248945;33760.46796490322;34293.314133717686;40857.75282359499;42624.360634591125;42742.14515709606;43269.35095973626;43399.34900976551;31437.685623143476;31457.370852583277;31704.365912681154;32112.678873211902;32485.18787030343;30839;30905.53641695421;30978;31146.377072458876;31468.685313146576;35321.64678353183;35382.64617353897;35384.29231415409;35456.11359716028;35954.10114747152;29975.850120749255;30200.5469917947;30353;30730.078097657108;30951.84524077365;22640.773592263868;22835.657465137705;23212.071517139124;23349.88325058364;23374.298771036894 15:40:43 INFO - PID 9637 | |2;jquery.html;559.6624068476344;575.5194412665425;581.3082431906032;584.2930054633892;587.6591576885407;22200.66698999514;23016.884915575418;23046.769532304672;23084.769152308472;23175.884120579394;23710.88144559279;24439.511209775796;24857.130000449986;24880.875595621997;25048.248552543453;6321.841953951165;6396.232452105731;6416.390442907939;6426.228852537679;6438.6780660967;6131.570790044699;6210.347913469066;6238.656873871935;6253.530985176108;6256.09286653435;6188.288346840103;6230.813075607716;6338.492920566344;6569.80290591283;6591.538592298541;6580.703868325937;6642.302558231413;6642.900356494656;6642.900356494656;6643.833904152435;6153.476954458876;6188.257409110891;6189.6286222826775;6191.659458729768;6199.845003874939;27991;29254.41491170186;29282.267943301587;29359.55960660592;29538.55692164619;2009.276660402254;2050.538628808521;2056.5372791121877;2057.331367305632;2066.782987786291;19372.612547749108;19610;19778.505537361536;19849.702254466196;19870.503237419034;2250.437390652337;2346.073301046077;2369.2536850891915;2416.4200591858003;2432.793212576933;118613;126977.36511317476;131406.3429682855;135877;137042;14443.89292155857;14639.634009149644;14760.630984225265;14762.70474590502;14982.625434364229;22834.42913927165;22972;22987;22996.7700322998;22999.540009200056;10031.347962382422;10044.799104017879;10220.540075696463;10227.488625568692;10259.640912568024;9343.439393636269;9496.335256531976;9505.619775209052;9534.618615255451;9630;8860;9003.14470125337;9093.681721139728;9104.81790364189;9112.772180695403;2515.9496810063697;2557.5268575313626;2591.1449221756775;2659.162363855379;2665.14715291105;945.8770359853175;967.4872317671645;975.2344409638541;984.9950750246203;992.950352482373;18874.43376698701;18932.337368192046;19302.03489825531;19392.70910936337;19530.511737206685;987.4618333008527;1018.0938964321759;1022.3865680591585;1023.4575674892319;1023.6724248240491;10366.378017318984;10565.735856603493;10624.78750424987;10771.461426928623;10839.67480975572;434317;443417;445111;451212;452719;102890;105066;105784.47107764412;105879.47060264804;107393.46303268433;1025.2310766924807;1064.5794911010107;1073.9087177589836;1118.8377685235596;1135.9772804543863;19737.506562335482;19912.90043549773;20026.198952042338;20373.185072597524;20629.69055464139;57882;58670.41329586649;59825;59863.10205346836;60670.99999999823;72069;73314.63342683253;73937.6303118481;74221;74383;14136.717265654836;14193.574192774233;14380.568582942109;14383.28083595795;14432.927835361175;20834.1666333345;20938.267160649306;21125.15499380069;22159.778402215772;22916.312510624706;17499.82500175033;17544.736828947833;17683.82316176873;17743.911280443514;18001.72997405066;13391.598252052454;13998.65003374883;15485.225738712794;16118.919405402898;16223.351065957702;18268.634627307645;18545.629087417907;18704.719429208846;18806.153723082767;19174.61650767005;13955.511557095859;14000.649983750487;14016.509422170175;14109.929450352682;14150.292485375485;17596.91201543984;17704.55738606545;17721.645567088843;17830;17955.461336159937 15:40:43 INFO - PID 9637 | |3;mootools.html;1322.5437224157665;1380.2132784312946;1392.227313840818;1394.1077710265427;1417.610157206768;14753.999999999987;15454;15501.302441390137;15522.922385388085;15524.456644017462;15275.159866207354;15372.923135384335;15392.846071539281;15393.307301171446;15411.3835446582;2585.6250843627663;2635.0513815026575;2670.1989403179064;2672.3319170207446;2685.1139124089004;2739.5068887600223;2756.2007017964866;2766.7094955029634;2771.5704065869822;2773.611694362791;2267.761885002076;2361.9645705314433;2677.5046616375935;2683.2755156107837;2710.850903200323;2652.9469410611778;2664.3871909460836;2671.2787547362104;2676.973230267692;2681.705012448629;2621.475704859036;2647.3911000469807;2659.4415172813733;2660.773834224074;2664.9067282645015;15061.397544098223;15227.847721522754;15254.08475491474;15341.156236406992;15419.460318888785;7604.847903041964;7849.607519624053;7895.842083158362;7922.564258965755;7961.243681850215;5198.480151984809;5264.973675131638;5452.4274951129955;5483.958047970873;5543.501084902337;1843.9631207375912;1880.3606773697009;1895.4597939587288;1926.4317026477222;1949.7660280766256;26646.467070658673;26719.46561068768;26739;26741.732582674314;26749.59875601887;6882.414994725505;6918.8962165567555;6958.547694399847;7093.609851458219;7128.144622645315;20084.89957550203;20091.799082008994;20204.59590808205;20237.595248094956;20241.696374554394;7501.699932002659;7517.661705223278;7520;7544.962275188699;7557.659905304275;6967.790966270919;7118.394936430462;7139.750108746169;7181.3895818854935;7209.459290553229;5527.2538207342295;5678.772849086073;5691.516221121251;5724.484796368347;5807.535397168216;1746.755454236408;1754.280744894587;1759.2523177649448;1784.2416972786514;1812.4562631210583;838.3251482556478;861.2593169873903;873.5413907698382;883.4346018548134;884.3676771108688;7030.472714546429;7069.187043489962;7071.43428525727;7180.640967951582;7197.928020719726;677.8678157759289;703.2299631903059;704.7075463682514;704.827317307263;708.5217478202193;4230.111676547959;4257.10600773841;4275.935860962088;4303.784810759449;4343.391925130484;20661;21379.67930481044;21422.892885535784;21424.357269281947;21495.247666331605;20164.89917550403;20839.166433342496;20992.265270715452;21043.68434473484;21305.467363315733;9673.22614190863;10102.39385636864;10163.390196588081;10181.796364072825;10268.229882758824;7650.4644674872225;7730.45886787942;7758.806029849299;7785.64964576584;7811.609419529114;17381.652366952843;17695.55761105931;17710.645787084442;17953.281868725106;18482.81517184811;17878.463646090637;18227.635447290715;18848.905755471682;19247.51881202981;19362.903185484545;11764.764704706029;12080.275183489019;12097.516099355928;12127.575534856238;12139.271643701406;13452.663683407993;13611.727765444437;13677.31613419345;13698.794518082435;13750.312484375941;10200.948995254976;10299.845502317321;10441.791164176826;10499.895001049892;10661.680149595524;10541.683749487527;10723.463826808473;10792.56829726802;10883.238173328107;10941.83587246208;9129.406588571721;9276.16514513697;9351.438913665203;9361.297902657192;9362.906370936204;6304.495640348853;6361.459275961595;6373.80878573625;6441.67791610427;6508;6517.804465866032;6605.438537724155;6615.834604134935;6655.101561289164;6676.566023208476 15:40:43 INFO - PID 9637 | |4;prototype.html;499.9550938538456;501.1480483178596;519.9795969910515;526.8599149071533;534.7299613695084;6102.755889764409;6207.224096987877;6307.211598550181;6311.684415779216;6395.744170233197;6188.5245901639255;6272.7804526841455;6358.745650173999;6365.199312302595;6371.331010243915;5159.948400516003;5202.739863006854;5254.8686282842855;5292.444293349201;5316.415194328621;4844.66087373884;5012.446141696068;5025.321581586494;5089.185730283156;5206.297149884774;5017.573506251954;5027.949720502803;5072.264521644378;5078.365204349457;5088.414832294278;4878.756062196893;4981.90036199274;5053.747312634354;5088.745562721886;5092.643514953973;4504.594586487232;4504.729716217037;4526.569975852289;4529.4791099023705;4534.36518887356;6210.472109870667;6227.968860155715;6281.209855191249;6342.556021078526;6342.778002769927;5749.195112684228;5793.248207101593;5793.565482588822;5794.275715535558;5834.241548598698;6579.9671001645165;6625.635590042546;6693.497987650946;6696.5647232929705;6709.161354830646;4807.61539076873;4867.659263851532;4882.121218180726;4947.183714687072;4947.802087916479;6952.721891124349;6996.68514916835;7022.613756243404;7058.470614703866;7125.92874071263;5068.467810879878;5076.13705670037;5080.060188864998;5089.491050894955;5098.923516147261;5076.416212135578;5139.254808052886;5149.249255253232;5154.484551544891;5174.379074511083;5575.860603484945;5631.183478395692;5645.830625081254;5666.744996475169;5721.828345149569;6305.464035557029;6679.298673639198;6686.933130668631;6697.229818570927;6760.3239676032;1670.4905003973904;1678.2951160512614;1688.6960347137633;1714.5370749897459;1744.5376975101608;1187.804012337972;1199.2145144930084;1211.7515909238762;1212.9386786561759;1226.2948804437306;5539.676194283478;5567.554595632339;5577.163425486128;5596.188552659923;5631.605787594829;6584.440322572539;6680.732770689216;6753.750556147129;6789.25318214996;6803.829904252433;5651.350094739076;5681.0910254359105;5712.514436272881;5825.79609713658;5828.213191219216;3539.5752509698486;3547.5388199534414;3584.0143960411096;3618.462153584716;3634.1823089804584;6496.675166241669;6531.216254049545;6556.508261880378;6613.404793568506;6668.466522678174;6953.304669533006;7016.333448322402;7018.824529386704;7023.92976070243;7098.574085554883;6495.253045899782;6510.9023364649565;6568.474522038321;6579.374959378755;6650.501212409089;6708.731650734111;6819.659017049227;6830.8633827324165;6859.588424694534;6875.965620171867;6685.829979753426;6712.664366781543;6721.395074443323;6829.965850170717;6839.521233513805;6421.775237866652;6474.5791523550815;6494.155759751202;6527.379898909596;6549.836254093495;4903.730294833818;4999.400071991385;5008.724520151427;5049.545540901337;5058.190689489664;6452.257990330984;6769.120014398097;6802.693878775566;6836.718894377472;6837.384635382839;6281.811545653638;6375.330590288138;6423.775167869102;6455.225372955276;6493;6533.843831535677;6533.876490140628;6551.672416379067;6576.112224849584;6602.141721576164;6396.776112836028;6444;6455.935440645533;6493.448056915215;6514.315996820265;6519.608823470607;6577.868442631217;6617.2721000688925;6618.966905165444;6642.605052938937;6359.1670330548195;6386;6420.26166990802;6458.418742313214;6493.350664933658 15:40:43 INFO - PID 9637 | |5;yui.html;877.1929824561403;889.2397000564517;908.137269593886;909.8908131024274;933.7992331648696;17894.463166105004;18470.16884240209;18526.351577694782;18622.534436639075;18628.161732722026;17170.055646939414;17266.482005539852;17352.652946941053;17700.46898593041;18625.44123676292;960.6829746183778;970.4613939263705;972.6255391674221;972.8443449048153;974.610155937627;983.5623147699276;987.5852142100299;994.174834887042;994.5872462927877;995.7659949911765;992.2310209587591;1029.341221618165;1032.7211652853725;1053.4943227250924;1061.6921092883056;997.3218211616098;1011.4437059617218;1013.2096964367768;1015.223354134088;1024.0783295034455;749.598964553961;753.6457864803533;756.2022066719609;756.8524137793132;758.332667252814;19731.60536789256;20424.285150019678;20436.0803763831;20436.591268174703;20447.182112715473;21004.264850730153;21379.8931005344;21497.785022149736;21698.457538561503;21755.238566650092;15419.537413877602;15619.921900390538;15752.606184845356;16141.192940352936;16551.25519351632;3705.555333359987;3727.7390582659223;3748.737588368815;3751.0247335692916;3751.643593858579;130107.34946325207;131832.3633527324;133739.33130334286;133886.3305683475;134074.65925340718;16606.418775342805;16615.83384166167;16838.494845154666;16990.575235618962;16998.57503562421;28760;30121.397572048438;30695;30856;30897.691023089483;7738.883916741253;7807.063152421632;7842.529448233125;7858.489198202098;7886.290233878978;3786.261678972574;3836.693064554829;3871.264459752638;3872.9225415492097;3906.628870257321;5345;5364;5383.192521121863;5491.615586908958;5521.365043020024;956.9425834449955;964.3683387381277;979.2900147393083;981.5975450065439;988.3871999360299;649.6264647827518;661.6460193796296;665.4377051391566;672.5460314287836;685.3900028974217;10763.83854242187;10932.610681079728;11183.273087249303;11234.269772464764;11386.259893107088;636.4303947966544;637.3053371824641;651.3616655677463;656.7996760987944;669.0633113640941;4708.387909571734;4733.053389322149;4753.952460475421;4772.451168115642;4803.95196048042;121755;122854.77145228433;123975;125209.37395312965;127238.36380818037;103189.48405257925;105178;105585;106332.46833765936;108026.13882375312;96650;96756.51621741847;98672.50663746636;99871.50064249632;101177.49411252896;8879.600417981077;8941.284697224337;8971.82056358856;9029.006809250846;9114.179723824887;41705.79147104367;44183.77908110439;44432.55567444284;44802.327965081204;44956.325655115856;53775.38673839791;54521.45478545322;55319;56060.719696401255;56839;13335.799963000369;13878.028538002243;13911.443542258196;13934.721305573628;14078.155310681392;14863.777043344575;15029.699406012038;15211.391544338545;15311.234438278265;15391.076535407912;13798.241096739775;14035.649108772363;14094.295285235903;14103.435862565382;14287.928560357132;14939.551813445614;15020;15157;15302.540923772305;15410.537683869501;14001.22993235382;14011.789823152865;14107;14335.211563363699;14553.708925821637;11265;11321.660350189508;11494.540218391505;11570.59502917394;11724.531018759155;11177.273477223955;11215.383153926612;11217.943910280397;11382.601608943647;11464.25482343645 15:40:43 INFO - PID 9637 | __end_tp_report 15:40:43 INFO - PID 9637 | __start_cc_report 15:40:43 INFO - PID 9637 | _x_x_mozilla_cycle_collect,367 15:40:43 INFO - PID 9637 | __end_cc_report 15:40:43 INFO - PID 9637 | __startTimestamp1504996843483__endTimestamp 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | ------- Summary: start ------- 15:40:43 INFO - PID 9637 | Number of tests: 6 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#0] dojo.html Cycles:165 Average:6093.35 Median:6354.21 stddev:841.61 (13.2%) stddev-sans-first:809.97 15:40:43 INFO - PID 9637 | Values: 3065.2 3086.0 3088.4 3091.2 3124.7 6023.5 6158.5 6215.1 6234.1 6262.2 6119.7 6132.6 6145.8 6166.1 6192.7 5676.9 5688.5 5737.0 5759.7 5812.3 5624.8 5647.4 5677.6 5685.1 5781.4 973.9 5696.7 5835.8 5844.2 5876.7 5274.7 5625.3 5664.2 5705.4 5818.4 5639.9 5691.1 5757.4 5762.5 5775.6 6208.5 6223.6 6232.9 6259.8 6287.3 6624.2 6628.6 6679.5 6696.3 6739.0 6421.0 6674.6 6752.3 6753.8 6822.0 6067.7 6080.2 6081.2 6125.6 6194.2 6810.4 6897.9 6924.3 6931.8 7029.6 6640.0 6690.8 6707.4 6715.6 6722.3 6659.1 6659.2 6661.7 6716.8 6753.2 6417.4 6525.8 6555.9 6572.8 6587.0 6550.6 6556.5 6620.0 6628.1 6641.1 5162.8 5200.7 5206.2 5251.9 5258.5 4596.2 4646.1 4646.1 4653.5 4655.4 5670.8 5672.7 5709.7 5721.8 5770.7 6412.7 6556.3 6579.8 6611.2 6673.1 5653.7 5710.8 5760.2 5765.5 5781.2 5695.6 5792.9 5799.4 5811.2 5819.6 6437.5 6444.5 6549.9 6564.6 6566.1 6438.7 6660.7 6681.6 6748.1 6757.2 6284.1 6427.4 6495.8 6500.3 6512.4 6549.3 6599.4 6602.4 6645.5 6661.1 6731.5 6815.5 6820.5 6825.7 6828.3 6471.5 6481.8 6485.0 6552.0 6577.1 6292.6 6364.9 6447.4 6543.1 6544.7 6295.4 6354.2 6402.6 6410.2 6411.3 6549.6 6564.7 6596.2 6606.3 6639.7 6260.0 6261.4 6339.9 6344.6 6345.4 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#1] ext.html Cycles:180 Average:36673.83 Median:3523.21 stddev:51799.91 (1470.2%) stddev-sans-first:51875.18 15:40:43 INFO - PID 9637 | Values: 799.1 834.4 840.6 840.8 842.0 37874.2 41621.6 41735.0 41756.6 41806.0 38024.4 38134.2 38243.0 38434.6 38629.6 6997.5 7045.2 7135.0 7763.7 7922.3 7749.5 7815.7 7817.5 7819.7 7845.5 7801.1 7835.8 7848.8 7853.9 7862.9 7757.2 7767.5 7772.1 7779.4 7820.8 7719.5 7756.1 7780.6 7785.0 7809.8 37636.4 37868.6 38004.0 38016.2 38115.8 3486.8 3521.3 3525.1 3525.3 3527.0 30856.2 30979.4 31104.8 31119.4 31166.0 5186.4 5266.6 5296.8 5301.8 5314.2 185768.0 185770.0 186216.0 186644.0 186769.0 40917.0 41760.6 47617.3 47649.5 47994.0 51183.5 51230.5 52182.5 52188.5 52337.2 15278.2 15321.4 15326.1 15328.2 15333.8 12464.4 12524.9 12563.4 12573.8 12610.2 14069.4 14263.3 14341.6 14395.8 14531.7 5696.9 5725.5 5730.5 5750.9 5782.4 990.3 1009.7 1021.8 1037.9 1041.6 22526.2 22735.1 22862.9 23141.7 23256.5 1104.8 1124.5 1126.8 1128.4 1132.3 11961.2 12055.3 12101.7 12237.3 12242.8 214776.0 215362.0 215741.0 215769.0 217228.0 52817.7 53429.2 53446.2 53457.2 53540.2 1441.6 1454.9 1463.7 1470.2 1497.9 22319.7 22432.8 22550.1 22746.4 22964.9 37666.2 37910.6 37985.0 38027.6 38042.2 195825.0 197453.0 197561.0 197807.0 197931.0 30621.1 30882.5 33288.5 33760.5 34293.3 40857.8 42624.4 42742.1 43269.4 43399.3 31437.7 31457.4 31704.4 32112.7 32485.2 30839.0 30905.5 30978.0 31146.4 31468.7 35321.6 35382.6 35384.3 35456.1 35954.1 29975.9 30200.5 30353.0 30730.1 30951.8 22640.8 22835.7 23212.1 23349.9 23374.3 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#2] jquery.html Cycles:180 Average:32998.60 Median:22875.37 stddev:75254.95 (329.0%) stddev-sans-first:75426.65 15:40:43 INFO - PID 9637 | Values: 559.7 575.5 581.3 584.3 587.7 22200.7 23016.9 23046.8 23084.8 23175.9 23710.9 24439.5 24857.1 24880.9 25048.2 6321.8 6396.2 6416.4 6426.2 6438.7 6131.6 6210.3 6238.7 6253.5 6256.1 6188.3 6230.8 6338.5 6569.8 6591.5 6580.7 6642.3 6642.9 6642.9 6643.8 6153.5 6188.3 6189.6 6191.7 6199.8 27991.0 29254.4 29282.3 29359.6 29538.6 2009.3 2050.5 2056.5 2057.3 2066.8 19372.6 19610.0 19778.5 19849.7 19870.5 2250.4 2346.1 2369.3 2416.4 2432.8 118613.0 126977.4 131406.3 135877.0 137042.0 14443.9 14639.6 14760.6 14762.7 14982.6 22834.4 22972.0 22987.0 22996.8 22999.5 10031.3 10044.8 10220.5 10227.5 10259.6 9343.4 9496.3 9505.6 9534.6 9630.0 8860.0 9003.1 9093.7 9104.8 9112.8 2515.9 2557.5 2591.1 2659.2 2665.1 945.9 967.5 975.2 985.0 993.0 18874.4 18932.3 19302.0 19392.7 19530.5 987.5 1018.1 1022.4 1023.5 1023.7 10366.4 10565.7 10624.8 10771.5 10839.7 434317.0 443417.0 445111.0 451212.0 452719.0 102890.0 105066.0 105784.5 105879.5 107393.5 1025.2 1064.6 1073.9 1118.8 1136.0 19737.5 19912.9 20026.2 20373.2 20629.7 57882.0 58670.4 59825.0 59863.1 60671.0 72069.0 73314.6 73937.6 74221.0 74383.0 14136.7 14193.6 14380.6 14383.3 14432.9 20834.2 20938.3 21125.2 22159.8 22916.3 17499.8 17544.7 17683.8 17743.9 18001.7 13391.6 13998.7 15485.2 16118.9 16223.4 18268.6 18545.6 18704.7 18806.2 19174.6 13955.5 14000.6 14016.5 14109.9 14150.3 17596.9 17704.6 17721.6 17830.0 17955.5 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#3] mootools.html Cycles:180 Average:9178.90 Median:14658.33 stddev:6752.15 (46.1%) stddev-sans-first:6745.30 15:40:43 INFO - PID 9637 | Values: 1322.5 1380.2 1392.2 1394.1 1417.6 14754.0 15454.0 15501.3 15522.9 15524.5 15275.2 15372.9 15392.8 15393.3 15411.4 2585.6 2635.1 2670.2 2672.3 2685.1 2739.5 2756.2 2766.7 2771.6 2773.6 2267.8 2362.0 2677.5 2683.3 2710.9 2652.9 2664.4 2671.3 2677.0 2681.7 2621.5 2647.4 2659.4 2660.8 2664.9 15061.4 15227.8 15254.1 15341.2 15419.5 7604.8 7849.6 7895.8 7922.6 7961.2 5198.5 5265.0 5452.4 5484.0 5543.5 1844.0 1880.4 1895.5 1926.4 1949.8 26646.5 26719.5 26739.0 26741.7 26749.6 6882.4 6918.9 6958.5 7093.6 7128.1 20084.9 20091.8 20204.6 20237.6 20241.7 7501.7 7517.7 7520.0 7545.0 7557.7 6967.8 7118.4 7139.8 7181.4 7209.5 5527.3 5678.8 5691.5 5724.5 5807.5 1746.8 1754.3 1759.3 1784.2 1812.5 838.3 861.3 873.5 883.4 884.4 7030.5 7069.2 7071.4 7180.6 7197.9 677.9 703.2 704.7 704.8 708.5 4230.1 4257.1 4275.9 4303.8 4343.4 20661.0 21379.7 21422.9 21424.4 21495.2 20164.9 20839.2 20992.3 21043.7 21305.5 9673.2 10102.4 10163.4 10181.8 10268.2 7650.5 7730.5 7758.8 7785.6 7811.6 17381.7 17695.6 17710.6 17953.3 18482.8 17878.5 18227.6 18848.9 19247.5 19362.9 11764.8 12080.3 12097.5 12127.6 12139.3 13452.7 13611.7 13677.3 13698.8 13750.3 10200.9 10299.8 10441.8 10499.9 10661.7 10541.7 10723.5 10792.6 10883.2 10941.8 9129.4 9276.2 9351.4 9361.3 9362.9 6304.5 6361.5 6373.8 6441.7 6508.0 6517.8 6605.4 6615.8 6655.1 6676.6 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#4] prototype.html Cycles:180 Average:5557.59 Median:6277.00 stddev:1566.37 (25.0%) stddev-sans-first:1524.07 15:40:43 INFO - PID 9637 | Values: 500.0 501.1 520.0 526.9 534.7 6102.8 6207.2 6307.2 6311.7 6395.7 6188.5 6272.8 6358.7 6365.2 6371.3 5159.9 5202.7 5254.9 5292.4 5316.4 4844.7 5012.4 5025.3 5089.2 5206.3 5017.6 5027.9 5072.3 5078.4 5088.4 4878.8 4981.9 5053.7 5088.7 5092.6 4504.6 4504.7 4526.6 4529.5 4534.4 6210.5 6228.0 6281.2 6342.6 6342.8 5749.2 5793.2 5793.6 5794.3 5834.2 6580.0 6625.6 6693.5 6696.6 6709.2 4807.6 4867.7 4882.1 4947.2 4947.8 6952.7 6996.7 7022.6 7058.5 7125.9 5068.5 5076.1 5080.1 5089.5 5098.9 5076.4 5139.3 5149.2 5154.5 5174.4 5575.9 5631.2 5645.8 5666.7 5721.8 6305.5 6679.3 6686.9 6697.2 6760.3 1670.5 1678.3 1688.7 1714.5 1744.5 1187.8 1199.2 1211.8 1212.9 1226.3 5539.7 5567.6 5577.2 5596.2 5631.6 6584.4 6680.7 6753.8 6789.3 6803.8 5651.4 5681.1 5712.5 5825.8 5828.2 3539.6 3547.5 3584.0 3618.5 3634.2 6496.7 6531.2 6556.5 6613.4 6668.5 6953.3 7016.3 7018.8 7023.9 7098.6 6495.3 6510.9 6568.5 6579.4 6650.5 6708.7 6819.7 6830.9 6859.6 6876.0 6685.8 6712.7 6721.4 6830.0 6839.5 6421.8 6474.6 6494.2 6527.4 6549.8 4903.7 4999.4 5008.7 5049.5 5058.2 6452.3 6769.1 6802.7 6836.7 6837.4 6281.8 6375.3 6423.8 6455.2 6493.0 6533.8 6533.9 6551.7 6576.1 6602.1 6396.8 6444.0 6455.9 6493.4 6514.3 6519.6 6577.9 6617.3 6619.0 6642.6 6359.2 6386.0 6420.3 6458.4 6493.4 15:40:43 INFO - PID 9637 | 15:40:43 INFO - PID 9637 | [#5] yui.html Cycles:180 Average:23615.39 Median:21438.84 stddev:34861.13 (162.6%) stddev-sans-first:34917.11 15:40:43 INFO - PID 9637 | Values: 877.2 889.2 908.1 909.9 933.8 17894.5 18470.2 18526.4 18622.5 18628.2 17170.1 17266.5 17352.7 17700.5 18625.4 960.7 970.5 972.6 972.8 974.6 983.6 987.6 994.2 994.6 995.8 992.2 1029.3 1032.7 1053.5 1061.7 997.3 1011.4 1013.2 1015.2 1024.1 749.6 753.6 756.2 756.9 758.3 19731.6 20424.3 20436.1 20436.6 20447.2 21004.3 21379.9 21497.8 21698.5 21755.2 15419.5 15619.9 15752.6 16141.2 16551.3 3705.6 3727.7 3748.7 3751.0 3751.6 130107.3 131832.4 133739.3 133886.3 134074.7 16606.4 16615.8 16838.5 16990.6 16998.6 28760.0 30121.4 30695.0 30856.0 30897.7 7738.9 7807.1 7842.5 7858.5 7886.3 3786.3 3836.7 3871.3 3872.9 3906.6 5345.0 5364.0 5383.2 5491.6 5521.4 956.9 964.4 979.3 981.6 988.4 649.6 661.6 665.4 672.5 685.4 10763.8 10932.6 11183.3 11234.3 11386.3 636.4 637.3 651.4 656.8 669.1 4708.4 4733.1 4754.0 4772.5 4804.0 121755.0 122854.8 123975.0 125209.4 127238.4 103189.5 105178.0 105585.0 106332.5 108026.1 96650.0 96756.5 98672.5 99871.5 101177.5 8879.6 8941.3 8971.8 9029.0 9114.2 41705.8 44183.8 44432.6 44802.3 44956.3 53775.4 54521.5 55319.0 56060.7 56839.0 13335.8 13878.0 13911.4 13934.7 14078.2 14863.8 15029.7 15211.4 15311.2 15391.1 13798.2 14035.6 14094.3 14103.4 14287.9 14939.6 15020.0 15157.0 15302.5 15410.5 14001.2 14011.8 14107.0 14335.2 14553.7 11265.0 11321.7 11494.5 11570.6 11724.5 11177.3 11215.4 11217.9 11382.6 11464.3 15:40:43 INFO - PID 9637 | -------- Summary: end -------- 15:40:43 INFO - PID 9637 | 15:40:44 INFO - TEST-INFO | 9637: exit 0 15:40:44 INFO - TEST-OK | dromaeo_css | took 1111891ms 15:40:44 INFO - TEST-START | kraken 15:40:44 INFO - Initialising browser for kraken test... 15:40:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56596/getInfo.html -profile /tmp/tmpaFaaVy/profile 15:40:44 INFO - TEST-INFO | started process 10021 (/builds/slave/test/build/application/firefox/firefox http://localhost:56596/getInfo.html) 15:40:50 INFO - TEST-INFO | 10021: exit 0 15:40:50 INFO - Browser initialized. 15:40:50 INFO - Running cycle 1/1 for kraken test... 15:40:50 INFO - Using env: {'DISPLAY': ':0', 15:40:50 INFO - 'HOME': '/home/cltbld', 15:40:50 INFO - 'JSGC_DISABLE_POISONING': '1', 15:40:50 INFO - 'LANG': 'en_US.UTF-8', 15:40:50 INFO - 'LANGUAGE': 'en_US:en', 15:40:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:40:50 INFO - 'LOGNAME': 'cltbld', 15:40:50 INFO - 'MAIL': '/var/mail/cltbld', 15:40:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:50 INFO - 'MOZ_ACCELERATED': '1', 15:40:50 INFO - 'MOZ_CRASHREPORTER': '1', 15:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:40:50 INFO - 'MOZ_NO_REMOTE': '1', 15:40:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:50 INFO - 'MOZ_WEBRENDER': '1', 15:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:50 INFO - 'NO_EM_RESTART': '1', 15:40:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:50 INFO - 'PWD': '/builds/slave/test', 15:40:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:50 INFO - 'RUST_BACKTRACE': 'full', 15:40:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:50 INFO - 'SHELL': '/bin/bash', 15:40:50 INFO - 'SHLVL': '1', 15:40:50 INFO - 'TERM': 'linux', 15:40:50 INFO - 'TMOUT': '86400', 15:40:50 INFO - 'USER': 'cltbld', 15:40:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504995672.635366-2120729365', 15:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:50 INFO - '_': '/tools/buildbot/bin/python'} 15:40:50 INFO - TEST-INFO | started process 10231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFaaVy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:51 INFO - PID 10231 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:40:51 INFO - PID 10231 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:40:51 INFO - PID 10231 | 15:40:51 INFO - PID 10231 | (/builds/slave/test/build/application/firefox/firefox:10292): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:40:51 INFO - PID 10231 | 15:41:02 INFO - PID 10231 | RSS: Main: 206467072 15:41:02 INFO - PID 10231 | 15:41:04 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56596/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:05 INFO - PID 10231 | RSS: Main: 214130688 15:41:05 INFO - PID 10231 | 15:41:08 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56596/tests/kraken/driver.html?testName=audio-dft) 15:41:09 INFO - PID 10231 | RSS: Main: 214609920 15:41:09 INFO - PID 10231 | 15:41:12 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56596/tests/kraken/driver.html?testName=audio-fft) 15:41:12 INFO - PID 10231 | RSS: Main: 208539648 15:41:12 INFO - PID 10231 | 15:41:15 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56596/tests/kraken/driver.html?testName=audio-oscillator) 15:41:15 INFO - PID 10231 | RSS: Main: 208470016 15:41:15 INFO - PID 10231 | 15:41:17 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:18 INFO - PID 10231 | RSS: Main: 208654336 15:41:18 INFO - PID 10231 | 15:41:21 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56596/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:22 INFO - PID 10231 | RSS: Main: 212271104 15:41:22 INFO - PID 10231 | 15:41:25 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56596/tests/kraken/driver.html?testName=imaging-desaturate) 15:41:26 INFO - PID 10231 | RSS: Main: 211558400 15:41:26 INFO - PID 10231 | 15:41:29 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56596/tests/kraken/driver.html?testName=json-parse-financial) 15:41:30 INFO - PID 10231 | RSS: Main: 213233664 15:41:30 INFO - PID 10231 | 15:41:31 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:41:32 INFO - PID 10231 | RSS: Main: 213286912 15:41:32 INFO - PID 10231 | 15:41:34 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:41:34 INFO - PID 10231 | RSS: Main: 213213184 15:41:34 INFO - PID 10231 | 15:41:36 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:41:37 INFO - PID 10231 | RSS: Main: 212652032 15:41:37 INFO - PID 10231 | 15:41:40 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:41 INFO - PID 10231 | RSS: Main: 213643264 15:41:41 INFO - PID 10231 | 15:41:44 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:41:44 INFO - PID 10231 | RSS: Main: 212819968 15:41:44 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | Cycle 1(1): loaded http://localhost:56596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56596/tests/kraken/driver.html?testName=ai-astar) 15:41:46 INFO - PID 10231 | RSS: Main: 215322624 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | __start_tp_report 15:41:46 INFO - PID 10231 | _x_x_mozilla_page_load 15:41:46 INFO - PID 10231 | _x_x_mozilla_page_load_details 15:41:46 INFO - PID 10231 | |i|pagename|runs| 15:41:46 INFO - PID 10231 | |0;ai-astar;113;124;113;110;109;108;113;111;114;117 15:41:46 INFO - PID 10231 | |1;audio-beat-detection;128;116;125;115;132;126;116;139;118;124 15:41:46 INFO - PID 10231 | |2;audio-dft;169;163;167;173;174;179;164;170;163;171 15:41:46 INFO - PID 10231 | |3;audio-fft;74;79;77;77;82;83;78;83;76;75 15:41:46 INFO - PID 10231 | |4;audio-oscillator;81;89;92;87;79;90;81;81;80;79 15:41:46 INFO - PID 10231 | |5;imaging-gaussian-blur;114;122;121;119;114;114;126;118;115;114 15:41:46 INFO - PID 10231 | |6;imaging-darkroom;150;161;160;151;148;149;149;159;149;149 15:41:46 INFO - PID 10231 | |7;imaging-desaturate;95;95;104;96;94;96;95;98;96;95 15:41:46 INFO - PID 10231 | |8;json-parse-financial;62;53;61;59;59;55;55;54;53;53 15:41:46 INFO - PID 10231 | |9;json-stringify-tinderbox;39;46;48;51;42;38;45;38;40;38 15:41:46 INFO - PID 10231 | |10;stanford-crypto-aes;91;82;82;83;79;81;79;77;77;76 15:41:46 INFO - PID 10231 | |11;stanford-crypto-ccm;130;130;124;120;126;125;123;123;131;117 15:41:46 INFO - PID 10231 | |12;stanford-crypto-pbkdf2;185;177;174;174;169;169;172;170;186;168 15:41:46 INFO - PID 10231 | |13;stanford-crypto-sha256-iterative;65;64;64;63;66;71;70;70;67;68 15:41:46 INFO - PID 10231 | __end_tp_report 15:41:46 INFO - PID 10231 | __start_cc_report 15:41:46 INFO - PID 10231 | _x_x_mozilla_cycle_collect,949 15:41:46 INFO - PID 10231 | __end_cc_report 15:41:46 INFO - PID 10231 | __startTimestamp1504996906833__endTimestamp 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | ------- Summary: start ------- 15:41:46 INFO - PID 10231 | Number of tests: 14 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:4.61 (4.1%) stddev-sans-first:4.89 15:41:46 INFO - PID 10231 | Values: 113.0 124.0 113.0 110.0 109.0 108.0 113.0 111.0 114.0 117.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:125.50 stddev:7.85 (6.3%) stddev-sans-first:8.19 15:41:46 INFO - PID 10231 | Values: 128.0 116.0 125.0 115.0 132.0 126.0 116.0 139.0 118.0 124.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#2] audio-dft Cycles:10 Average:169.30 Median:170.50 stddev:5.23 (3.1%) stddev-sans-first:5.55 15:41:46 INFO - PID 10231 | Values: 169.0 163.0 167.0 173.0 174.0 179.0 164.0 170.0 163.0 171.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#3] audio-fft Cycles:10 Average:78.40 Median:78.50 stddev:3.27 (4.2%) stddev-sans-first:3.06 15:41:46 INFO - PID 10231 | Values: 74.0 79.0 77.0 77.0 82.0 83.0 78.0 83.0 76.0 75.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:84.00 stddev:5.02 (6.0%) stddev-sans-first:5.21 15:41:46 INFO - PID 10231 | Values: 81.0 89.0 92.0 87.0 79.0 90.0 81.0 81.0 80.0 79.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.50 stddev:4.24 (3.6%) stddev-sans-first:4.28 15:41:46 INFO - PID 10231 | Values: 114.0 122.0 121.0 119.0 114.0 114.0 126.0 118.0 115.0 114.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:150.50 stddev:5.25 (3.5%) stddev-sans-first:5.49 15:41:46 INFO - PID 10231 | Values: 150.0 161.0 160.0 151.0 148.0 149.0 149.0 159.0 149.0 149.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:95.50 stddev:2.88 (3.0%) stddev-sans-first:3.00 15:41:46 INFO - PID 10231 | Values: 95.0 95.0 104.0 96.0 94.0 96.0 95.0 98.0 96.0 95.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:3.50 (6.1%) stddev-sans-first:3.07 15:41:46 INFO - PID 10231 | Values: 62.0 53.0 61.0 59.0 59.0 55.0 55.0 54.0 53.0 53.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#9] json-stringify-tinderbox Cycles:10 Average:42.50 Median:43.50 stddev:4.72 (10.9%) stddev-sans-first:4.83 15:41:46 INFO - PID 10231 | Values: 39.0 46.0 48.0 51.0 42.0 38.0 45.0 38.0 40.0 38.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.50 stddev:4.35 (5.3%) stddev-sans-first:2.55 15:41:46 INFO - PID 10231 | Values: 91.0 82.0 82.0 83.0 79.0 81.0 79.0 77.0 77.0 76.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.50 stddev:4.53 (3.6%) stddev-sans-first:4.42 15:41:46 INFO - PID 10231 | Values: 130.0 130.0 124.0 120.0 126.0 125.0 123.0 123.0 131.0 117.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:6.48 (3.7%) stddev-sans-first:5.63 15:41:46 INFO - PID 10231 | Values: 185.0 177.0 174.0 174.0 169.0 169.0 172.0 170.0 186.0 168.0 15:41:46 INFO - PID 10231 | 15:41:46 INFO - PID 10231 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:2.86 (4.2%) stddev-sans-first:2.96 15:41:46 INFO - PID 10231 | Values: 65.0 64.0 64.0 63.0 66.0 71.0 70.0 70.0 67.0 68.0 15:41:46 INFO - PID 10231 | -------- Summary: end -------- 15:41:46 INFO - PID 10231 | 15:41:47 INFO - PID 10231 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:41:47 INFO - TEST-INFO | 10231: exit 0 15:41:47 INFO - TEST-OK | kraken | took 63428ms 15:41:47 INFO - SUITE-END | took 1175s 15:41:47 INFO - Completed test suite (00:19:35) 15:41:47 INFO - javascript benchmark 15:41:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8345.035051300516, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.203047207726, 3085.95371069434, 3088.3668847886183, 3091.1962889648685, 3124.7031532004453, 6023.548233882465, 6158.507319414442, 6215.12988181655, 6234.127222188898, 6262.248530176374, 6119.7246123924415, 6132.632042077478, 6145.846353841156, 6166.105914642374, 6192.72132754026, 5676.943230567704, 5688.459596338352, 5737.0, 5759.654420734749, 5812.302523697141, 5624.831255062334, 5647.37878833328, 5677.602567820254, 5685.147227915804, 5781.421857814227, 973.9173687319302, 5696.658200507962, 5835.766569337221, 5844.152597873306, 5876.7355469004, 5274.657147285453, 5625.268715067056, 5664.235328230678, 5705.400932902027, 5818.44724751148, 5639.887202255973, 5691.117876729114, 5757.424257574251, 5762.510186634141, 5775.5957083004205, 6208.5033197344555, 6223.5954662947215, 6232.9065064023625, 6259.812205633838, 6287.339829317902, 6624.171978502687, 6628.635425051621, 6679.465642748569, 6696.330366963313, 6739.0, 6421.0, 6674.566153200027, 6752.291009444036, 6753.763618273386, 6822.0, 6067.666278354689, 6080.2399700037495, 6081.209442772411, 6125.5712100153005, 6194.163787888668, 6810.421114205348, 6897.896531552031, 6924.307569243036, 6931.826704332432, 7029.61337126463, 6639.966800166065, 6690.832729181712, 6707.396334329934, 6715.630640314829, 6722.327767223239, 6659.134312539339, 6659.167604049494, 6661.733530658719, 6716.832079197961, 6753.223379311344, 6417.422431981144, 6525.836854078591, 6555.868882622321, 6572.80281591553, 6587.0, 6550.639714815731, 6556.508261880378, 6619.966900165565, 6628.138342015507, 6641.070250164981, 5162.767675454614, 5200.6879587224885, 5206.167013277857, 5251.868703282448, 5258.474152584788, 4596.195665758479, 4646.09401166776, 4646.117237724821, 4653.464851542049, 4655.4180727409075, 5670.8015219467125, 5672.659640421588, 5709.68596727184, 5721.828345149652, 5770.711464426762, 6412.7114279857515, 6556.311587283267, 6579.78274019308, 6611.173603299588, 6673.132492775908, 5653.745581448845, 5710.8001219957105, 5760.193572899798, 5765.509931655773, 5781.219535362757, 5695.60130790849, 5792.88414231713, 5799.3620701722775, 5811.215485909348, 5819.563532735062, 6437.549371544041, 6444.484441244689, 6549.901751473732, 6564.606123632598, 6566.080748695186, 6438.742450301936, 6660.733570657313, 6681.599104053772, 6748.089007983859, 6757.189137303555, 6284.088807123033, 6427.357264273723, 6495.837604059936, 6500.317466666121, 6512.413882750575, 6549.279579246184, 6599.373059559334, 6602.372774586406, 6645.468362531083, 6661.134052573135, 6731.461483081243, 6815.454763618799, 6820.488463365168, 6825.658717064226, 6828.317168283132, 6471.514636402383, 6481.805545833632, 6484.962406015015, 6552.017197420425, 6577.14497115372, 6292.622442653455, 6364.93635063662, 6447.387498187664, 6543.051257567721, 6544.705488252945, 6295.370462953668, 6354.205724284465, 6402.6158430494315, 6410.230772307166, 6411.326810684997, 6549.6070235786, 6564.737410503526, 6596.208454985433, 6606.339366063356, 6639.7012134455035, 6259.96870015647, 6261.405166509175, 6339.873202535831, 6344.555881088279, 6345.428911397997], "value": 6032.394962004031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.1409235072297, 834.3908946469078, 840.6217202258981, 840.8066144786695, 841.970531031414, 37874.24251514968, 41621.58378416215, 41735.0, 41756.58243417565, 41805.9548511287, 38024.429633555446, 38134.23731525375, 38243.0, 38434.61565384345, 38629.61370386295, 6997.475189360793, 7045.225025247219, 7135.036770036057, 7763.689452421896, 7922.326602238817, 7749.496282741632, 7815.726449574266, 7817.530948143101, 7819.726309579166, 7845.490043147206, 7801.063872335328, 7835.764927052198, 7848.843023139534, 7853.939718138064, 7862.921370786276, 7757.224277572254, 7767.53394796314, 7772.067351917778, 7779.3776497880035, 7820.76537703867, 7719.459637825355, 7756.146823849372, 7780.649870755773, 7785.026871641045, 7809.843803123963, 37636.435453467944, 37868.62131378678, 38004.0, 38016.23967520662, 38115.80942095272, 3486.8256587170795, 3521.295740851814, 3525.11872031992, 3525.2773181497987, 3526.964730352715, 30856.228594285098, 30979.380412391627, 31104.844475777703, 31119.37761244785, 31166.0, 5186.403563590197, 5266.605004624668, 5296.841094767125, 5301.840944771663, 5314.229436731691, 185768.0, 185770.0, 186216.0, 186644.0, 186769.0, 40917.0, 41760.58239417567, 47617.285740713916, 47649.52350476451, 47994.0, 51183.488165118615, 51230.48769512332, 52182.47817521852, 52188.47811521912, 52337.21494177591, 15278.15970121654, 15321.387144514094, 15326.080435173924, 15328.156951367782, 15333.769993450107, 12464.376781160905, 12524.937375313066, 12563.434645440977, 12573.811392829115, 12610.180338277982, 14069.437222510986, 14263.286835658175, 14341.64145896361, 14395.78406323906, 14531.709365812625, 5696.943030569641, 5725.541956643458, 5730.455606717355, 5750.942490575125, 5782.3639399666, 990.2820455170088, 1009.7021378693303, 1021.8211812932707, 1037.9429131397694, 1041.578160844844, 22526.21158259453, 22735.09059637629, 22862.885685571797, 23141.652875206884, 23256.53486930252, 1104.7845670094255, 1124.4658787076073, 1126.7859106769852, 1128.373752567333, 1132.3206076354122, 11961.222520536137, 12055.336956467478, 12101.697457563456, 12237.265764054186, 12242.81635775464, 214776.0, 215362.0, 215741.0, 215769.0, 217228.0, 52817.73591132097, 53429.1985620216, 53446.19830702543, 53457.1981420279, 53540.196897046575, 1441.6467965348347, 1454.9127052376891, 1463.6633574277976, 1470.154661069889, 1497.91012539248, 22319.665205022262, 22432.775672243068, 22550.097996079974, 22746.43133921665, 22964.885175574684, 37666.24667506689, 37910.62089379071, 37985.0, 38027.61972380352, 38042.23915521729, 195825.0, 197453.0, 197561.0, 197807.0, 197931.0, 30621.08136755901, 30882.53676194814, 33288.50067248945, 33760.46796490322, 34293.314133717686, 40857.75282359499, 42624.360634591125, 42742.14515709606, 43269.35095973626, 43399.34900976551, 31437.685623143476, 31457.370852583277, 31704.365912681154, 32112.678873211902, 32485.18787030343, 30839.0, 30905.53641695421, 30978.0, 31146.377072458876, 31468.685313146576, 35321.64678353183, 35382.64617353897, 35384.29231415409, 35456.11359716028, 35954.10114747152, 29975.850120749255, 30200.5469917947, 30353.0, 30730.078097657108, 30951.84524077365, 22640.773592263868, 22835.657465137705, 23212.071517139124, 23349.88325058364, 23374.298771036894], "value": 16919.909627056924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6624068476344, 575.5194412665425, 581.3082431906032, 584.2930054633892, 587.6591576885407, 22200.66698999514, 23016.884915575418, 23046.769532304672, 23084.769152308472, 23175.884120579394, 23710.88144559279, 24439.511209775796, 24857.130000449986, 24880.875595621997, 25048.248552543453, 6321.841953951165, 6396.232452105731, 6416.390442907939, 6426.228852537679, 6438.6780660967, 6131.570790044699, 6210.347913469066, 6238.656873871935, 6253.530985176108, 6256.09286653435, 6188.288346840103, 6230.813075607716, 6338.492920566344, 6569.80290591283, 6591.538592298541, 6580.703868325937, 6642.302558231413, 6642.900356494656, 6642.900356494656, 6643.833904152435, 6153.476954458876, 6188.257409110891, 6189.6286222826775, 6191.659458729768, 6199.845003874939, 27991.0, 29254.41491170186, 29282.267943301587, 29359.55960660592, 29538.55692164619, 2009.276660402254, 2050.538628808521, 2056.5372791121877, 2057.331367305632, 2066.782987786291, 19372.612547749108, 19610.0, 19778.505537361536, 19849.702254466196, 19870.503237419034, 2250.437390652337, 2346.073301046077, 2369.2536850891915, 2416.4200591858003, 2432.793212576933, 118613.0, 126977.36511317476, 131406.3429682855, 135877.0, 137042.0, 14443.89292155857, 14639.634009149644, 14760.630984225265, 14762.70474590502, 14982.625434364229, 22834.42913927165, 22972.0, 22987.0, 22996.7700322998, 22999.540009200056, 10031.347962382422, 10044.799104017879, 10220.540075696463, 10227.488625568692, 10259.640912568024, 9343.439393636269, 9496.335256531976, 9505.619775209052, 9534.618615255451, 9630.0, 8860.0, 9003.14470125337, 9093.681721139728, 9104.81790364189, 9112.772180695403, 2515.9496810063697, 2557.5268575313626, 2591.1449221756775, 2659.162363855379, 2665.14715291105, 945.8770359853175, 967.4872317671645, 975.2344409638541, 984.9950750246203, 992.950352482373, 18874.43376698701, 18932.337368192046, 19302.03489825531, 19392.70910936337, 19530.511737206685, 987.4618333008527, 1018.0938964321759, 1022.3865680591585, 1023.4575674892319, 1023.6724248240491, 10366.378017318984, 10565.735856603493, 10624.78750424987, 10771.461426928623, 10839.67480975572, 434317.0, 443417.0, 445111.0, 451212.0, 452719.0, 102890.0, 105066.0, 105784.47107764412, 105879.47060264804, 107393.46303268433, 1025.2310766924807, 1064.5794911010107, 1073.9087177589836, 1118.8377685235596, 1135.9772804543863, 19737.506562335482, 19912.90043549773, 20026.198952042338, 20373.185072597524, 20629.69055464139, 57882.0, 58670.41329586649, 59825.0, 59863.10205346836, 60670.99999999823, 72069.0, 73314.63342683253, 73937.6303118481, 74221.0, 74383.0, 14136.717265654836, 14193.574192774233, 14380.568582942109, 14383.28083595795, 14432.927835361175, 20834.1666333345, 20938.267160649306, 21125.15499380069, 22159.778402215772, 22916.312510624706, 17499.82500175033, 17544.736828947833, 17683.82316176873, 17743.911280443514, 18001.72997405066, 13391.598252052454, 13998.65003374883, 15485.225738712794, 16118.919405402898, 16223.351065957702, 18268.634627307645, 18545.629087417907, 18704.719429208846, 18806.153723082767, 19174.61650767005, 13955.511557095859, 14000.649983750487, 14016.509422170175, 14109.929450352682, 14150.292485375485, 17596.91201543984, 17704.55738606545, 17721.645567088843, 17830.0, 17955.461336159937], "value": 11743.378686596268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.5437224157665, 1380.2132784312946, 1392.227313840818, 1394.1077710265427, 1417.610157206768, 14753.999999999987, 15454.0, 15501.302441390137, 15522.922385388085, 15524.456644017462, 15275.159866207354, 15372.923135384335, 15392.846071539281, 15393.307301171446, 15411.3835446582, 2585.6250843627663, 2635.0513815026575, 2670.1989403179064, 2672.3319170207446, 2685.1139124089004, 2739.5068887600223, 2756.2007017964866, 2766.7094955029634, 2771.5704065869822, 2773.611694362791, 2267.761885002076, 2361.9645705314433, 2677.5046616375935, 2683.2755156107837, 2710.850903200323, 2652.9469410611778, 2664.3871909460836, 2671.2787547362104, 2676.973230267692, 2681.705012448629, 2621.475704859036, 2647.3911000469807, 2659.4415172813733, 2660.773834224074, 2664.9067282645015, 15061.397544098223, 15227.847721522754, 15254.08475491474, 15341.156236406992, 15419.460318888785, 7604.847903041964, 7849.607519624053, 7895.842083158362, 7922.564258965755, 7961.243681850215, 5198.480151984809, 5264.973675131638, 5452.4274951129955, 5483.958047970873, 5543.501084902337, 1843.9631207375912, 1880.3606773697009, 1895.4597939587288, 1926.4317026477222, 1949.7660280766256, 26646.467070658673, 26719.46561068768, 26739.0, 26741.732582674314, 26749.59875601887, 6882.414994725505, 6918.8962165567555, 6958.547694399847, 7093.609851458219, 7128.144622645315, 20084.89957550203, 20091.799082008994, 20204.59590808205, 20237.595248094956, 20241.696374554394, 7501.699932002659, 7517.661705223278, 7520.0, 7544.962275188699, 7557.659905304275, 6967.790966270919, 7118.394936430462, 7139.750108746169, 7181.3895818854935, 7209.459290553229, 5527.2538207342295, 5678.772849086073, 5691.516221121251, 5724.484796368347, 5807.535397168216, 1746.755454236408, 1754.280744894587, 1759.2523177649448, 1784.2416972786514, 1812.4562631210583, 838.3251482556478, 861.2593169873903, 873.5413907698382, 883.4346018548134, 884.3676771108688, 7030.472714546429, 7069.187043489962, 7071.43428525727, 7180.640967951582, 7197.928020719726, 677.8678157759289, 703.2299631903059, 704.7075463682514, 704.827317307263, 708.5217478202193, 4230.111676547959, 4257.10600773841, 4275.935860962088, 4303.784810759449, 4343.391925130484, 20661.0, 21379.67930481044, 21422.892885535784, 21424.357269281947, 21495.247666331605, 20164.89917550403, 20839.166433342496, 20992.265270715452, 21043.68434473484, 21305.467363315733, 9673.22614190863, 10102.39385636864, 10163.390196588081, 10181.796364072825, 10268.229882758824, 7650.4644674872225, 7730.45886787942, 7758.806029849299, 7785.64964576584, 7811.609419529114, 17381.652366952843, 17695.55761105931, 17710.645787084442, 17953.281868725106, 18482.81517184811, 17878.463646090637, 18227.635447290715, 18848.905755471682, 19247.51881202981, 19362.903185484545, 11764.764704706029, 12080.275183489019, 12097.516099355928, 12127.575534856238, 12139.271643701406, 13452.663683407993, 13611.727765444437, 13677.31613419345, 13698.794518082435, 13750.312484375941, 10200.948995254976, 10299.845502317321, 10441.791164176826, 10499.895001049892, 10661.680149595524, 10541.683749487527, 10723.463826808473, 10792.56829726802, 10883.238173328107, 10941.83587246208, 9129.406588571721, 9276.16514513697, 9351.438913665203, 9361.297902657192, 9362.906370936204, 6304.495640348853, 6361.459275961595, 6373.80878573625, 6441.67791610427, 6508.0, 6517.804465866032, 6605.438537724155, 6615.834604134935, 6655.101561289164, 6676.566023208476], "value": 6482.303831377678, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.9550938538456, 501.1480483178596, 519.9795969910515, 526.8599149071533, 534.7299613695084, 6102.755889764409, 6207.224096987877, 6307.211598550181, 6311.684415779216, 6395.744170233197, 6188.5245901639255, 6272.7804526841455, 6358.745650173999, 6365.199312302595, 6371.331010243915, 5159.948400516003, 5202.739863006854, 5254.8686282842855, 5292.444293349201, 5316.415194328621, 4844.66087373884, 5012.446141696068, 5025.321581586494, 5089.185730283156, 5206.297149884774, 5017.573506251954, 5027.949720502803, 5072.264521644378, 5078.365204349457, 5088.414832294278, 4878.756062196893, 4981.90036199274, 5053.747312634354, 5088.745562721886, 5092.643514953973, 4504.594586487232, 4504.729716217037, 4526.569975852289, 4529.4791099023705, 4534.36518887356, 6210.472109870667, 6227.968860155715, 6281.209855191249, 6342.556021078526, 6342.778002769927, 5749.195112684228, 5793.248207101593, 5793.565482588822, 5794.275715535558, 5834.241548598698, 6579.9671001645165, 6625.635590042546, 6693.497987650946, 6696.5647232929705, 6709.161354830646, 4807.61539076873, 4867.659263851532, 4882.121218180726, 4947.183714687072, 4947.802087916479, 6952.721891124349, 6996.68514916835, 7022.613756243404, 7058.470614703866, 7125.92874071263, 5068.467810879878, 5076.13705670037, 5080.060188864998, 5089.491050894955, 5098.923516147261, 5076.416212135578, 5139.254808052886, 5149.249255253232, 5154.484551544891, 5174.379074511083, 5575.860603484945, 5631.183478395692, 5645.830625081254, 5666.744996475169, 5721.828345149569, 6305.464035557029, 6679.298673639198, 6686.933130668631, 6697.229818570927, 6760.3239676032, 1670.4905003973904, 1678.2951160512614, 1688.6960347137633, 1714.5370749897459, 1744.5376975101608, 1187.804012337972, 1199.2145144930084, 1211.7515909238762, 1212.9386786561759, 1226.2948804437306, 5539.676194283478, 5567.554595632339, 5577.163425486128, 5596.188552659923, 5631.605787594829, 6584.440322572539, 6680.732770689216, 6753.750556147129, 6789.25318214996, 6803.829904252433, 5651.350094739076, 5681.0910254359105, 5712.514436272881, 5825.79609713658, 5828.213191219216, 3539.5752509698486, 3547.5388199534414, 3584.0143960411096, 3618.462153584716, 3634.1823089804584, 6496.675166241669, 6531.216254049545, 6556.508261880378, 6613.404793568506, 6668.466522678174, 6953.304669533006, 7016.333448322402, 7018.824529386704, 7023.92976070243, 7098.574085554883, 6495.253045899782, 6510.9023364649565, 6568.474522038321, 6579.374959378755, 6650.501212409089, 6708.731650734111, 6819.659017049227, 6830.8633827324165, 6859.588424694534, 6875.965620171867, 6685.829979753426, 6712.664366781543, 6721.395074443323, 6829.965850170717, 6839.521233513805, 6421.775237866652, 6474.5791523550815, 6494.155759751202, 6527.379898909596, 6549.836254093495, 4903.730294833818, 4999.400071991385, 5008.724520151427, 5049.545540901337, 5058.190689489664, 6452.257990330984, 6769.120014398097, 6802.693878775566, 6836.718894377472, 6837.384635382839, 6281.811545653638, 6375.330590288138, 6423.775167869102, 6455.225372955276, 6493.0, 6533.843831535677, 6533.876490140628, 6551.672416379067, 6576.112224849584, 6602.141721576164, 6396.776112836028, 6444.0, 6455.935440645533, 6493.448056915215, 6514.315996820265, 6519.608823470607, 6577.868442631217, 6617.2721000688925, 6618.966905165444, 6642.605052938937, 6359.1670330548195, 6386.0, 6420.26166990802, 6458.418742313214, 6493.350664933658], "value": 5092.40209612399, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.1929824561403, 889.2397000564517, 908.137269593886, 909.8908131024274, 933.7992331648696, 17894.463166105004, 18470.16884240209, 18526.351577694782, 18622.534436639075, 18628.161732722026, 17170.055646939414, 17266.482005539852, 17352.652946941053, 17700.46898593041, 18625.44123676292, 960.6829746183778, 970.4613939263705, 972.6255391674221, 972.8443449048153, 974.610155937627, 983.5623147699276, 987.5852142100299, 994.174834887042, 994.5872462927877, 995.7659949911765, 992.2310209587591, 1029.341221618165, 1032.7211652853725, 1053.4943227250924, 1061.6921092883056, 997.3218211616098, 1011.4437059617218, 1013.2096964367768, 1015.223354134088, 1024.0783295034455, 749.598964553961, 753.6457864803533, 756.2022066719609, 756.8524137793132, 758.332667252814, 19731.60536789256, 20424.285150019678, 20436.0803763831, 20436.591268174703, 20447.182112715473, 21004.264850730153, 21379.8931005344, 21497.785022149736, 21698.457538561503, 21755.238566650092, 15419.537413877602, 15619.921900390538, 15752.606184845356, 16141.192940352936, 16551.25519351632, 3705.555333359987, 3727.7390582659223, 3748.737588368815, 3751.0247335692916, 3751.643593858579, 130107.34946325207, 131832.3633527324, 133739.33130334286, 133886.3305683475, 134074.65925340718, 16606.418775342805, 16615.83384166167, 16838.494845154666, 16990.575235618962, 16998.57503562421, 28760.0, 30121.397572048438, 30695.0, 30856.0, 30897.691023089483, 7738.883916741253, 7807.063152421632, 7842.529448233125, 7858.489198202098, 7886.290233878978, 3786.261678972574, 3836.693064554829, 3871.264459752638, 3872.9225415492097, 3906.628870257321, 5345.0, 5364.0, 5383.192521121863, 5491.615586908958, 5521.365043020024, 956.9425834449955, 964.3683387381277, 979.2900147393083, 981.5975450065439, 988.3871999360299, 649.6264647827518, 661.6460193796296, 665.4377051391566, 672.5460314287836, 685.3900028974217, 10763.83854242187, 10932.610681079728, 11183.273087249303, 11234.269772464764, 11386.259893107088, 636.4303947966544, 637.3053371824641, 651.3616655677463, 656.7996760987944, 669.0633113640941, 4708.387909571734, 4733.053389322149, 4753.952460475421, 4772.451168115642, 4803.95196048042, 121755.0, 122854.77145228433, 123975.0, 125209.37395312965, 127238.36380818037, 103189.48405257925, 105178.0, 105585.0, 106332.46833765936, 108026.13882375312, 96650.0, 96756.51621741847, 98672.50663746636, 99871.50064249632, 101177.49411252896, 8879.600417981077, 8941.284697224337, 8971.82056358856, 9029.006809250846, 9114.179723824887, 41705.79147104367, 44183.77908110439, 44432.55567444284, 44802.327965081204, 44956.325655115856, 53775.38673839791, 54521.45478545322, 55319.0, 56060.719696401255, 56839.0, 13335.799963000369, 13878.028538002243, 13911.443542258196, 13934.721305573628, 14078.155310681392, 14863.777043344575, 15029.699406012038, 15211.391544338545, 15311.234438278265, 15391.076535407912, 13798.241096739775, 14035.649108772363, 14094.295285235903, 14103.435862565382, 14287.928560357132, 14939.551813445614, 15020.0, 15157.0, 15302.540923772305, 15410.537683869501, 14001.22993235382, 14011.789823152865, 14107.0, 14335.211563363699, 14553.708925821637, 11265.0, 11321.660350189508, 11494.540218391505, 11570.59502917394, 11724.531018759155, 11177.273477223955, 11215.383153926612, 11217.943910280397, 11382.601608943647, 11464.25482343645], "value": 8535.137065405132, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 124.0, 113.0, 110.0, 109.0, 108.0, 113.0, 111.0, 114.0, 117.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 116.0, 125.0, 115.0, 132.0, 126.0, 116.0, 139.0, 118.0, 124.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 167.0, 173.0, 174.0, 179.0, 164.0, 170.0, 163.0, 171.0], "value": 169.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 77.0, 77.0, 82.0, 83.0, 78.0, 83.0, 76.0, 75.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 92.0, 87.0, 79.0, 90.0, 81.0, 81.0, 80.0, 79.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 121.0, 119.0, 114.0, 114.0, 126.0, 118.0, 115.0, 114.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 161.0, 160.0, 151.0, 148.0, 149.0, 149.0, 159.0, 149.0, 149.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 104.0, 96.0, 94.0, 96.0, 95.0, 98.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 53.0, 61.0, 59.0, 59.0, 55.0, 55.0, 54.0, 53.0, 53.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 46.0, 48.0, 51.0, 42.0, 38.0, 45.0, 38.0, 40.0, 38.0], "value": 42.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 82.0, 83.0, 79.0, 81.0, 79.0, 77.0, 77.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 124.0, 120.0, 126.0, 125.0, 123.0, 123.0, 131.0, 117.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 177.0, 174.0, 174.0, 169.0, 169.0, 172.0, 170.0, 186.0, 168.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 66.0, 71.0, 70.0, 70.0, 67.0, 68.0], "value": 66.8, "unit": "score"}]}]} 15:41:48 INFO - Return code: 0 15:41:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:41:48 INFO - # TBPL SUCCESS # 15:41:48 INFO - Running post-action listener: _package_coverage_data 15:41:48 INFO - Running post-action listener: _resource_record_post_action 15:41:48 INFO - [mozharness: 2017-09-09 22:41:48.101340Z] Finished run-tests step (success) 15:41:48 INFO - Running post-run listener: _resource_record_post_run 15:41:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 57344; Write bytes: 302956544; Read time: 44; Write time: 242004 15:41:48 INFO - TinderboxPrint: CPU usage
13.3% 15:41:48 INFO - TinderboxPrint: I/O read bytes / time
57,344 / 44 15:41:48 INFO - TinderboxPrint: I/O write bytes / time
302,956,544 / 242,004 15:41:48 INFO - TinderboxPrint: CPU idle
8,238.3 (86.7%) 15:41:48 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 15:41:48 INFO - TinderboxPrint: Swap in / out
0 / 0 15:41:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13340672; Read time: 0; Write time: 1360 15:41:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:41:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 57344; Write bytes: 289533952; Read time: 44; Write time: 240644 15:41:48 INFO - Running post-run listener: _upload_blobber_files 15:41:48 INFO - Blob upload gear active. 15:41:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:41:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:41:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:41:49 INFO - (blobuploader) - INFO - Open directory for files ... 15:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:50 INFO - (blobuploader) - INFO - Done attempting. 15:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:57 INFO - (blobuploader) - INFO - Done attempting. 15:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:57 INFO - (blobuploader) - INFO - Done attempting. 15:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:59 INFO - (blobuploader) - INFO - Done attempting. 15:41:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:59 INFO - Return code: 0 15:41:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/307240d3dfdf277ed22f2867099b566c177d4ddff3df44a81ef3f0ecf80921a521fdcba406dafd2915bbab83bb63204631a35979d239401467ca18b3cd64e023", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d50d49b4d4039f4302d5f7bfb9c4a4614c83e42ed092d1ef8e35bcd75ea67bf35262c35b910f489f021c49bc2e43ac9c035e25cdcd9a8863d16bef7c32e7ab4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cde78c4fe44e2db01ba4d70c02d0da61df63707e5acc082a072e552c898a954921dddd51c83c9b2db262258f2721a2a64ff631e74dd4890de86e9e488a2c02b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f776699e499065cab99e017d280e5d2c917236b846934f3dcb446f224d2027922b7c40b4362afdff31e7792cc471704809e99ab0227cb4096508f98e9a63bdb"} 15:41:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:59 INFO - Contents: 15:41:59 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/307240d3dfdf277ed22f2867099b566c177d4ddff3df44a81ef3f0ecf80921a521fdcba406dafd2915bbab83bb63204631a35979d239401467ca18b3cd64e023", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d50d49b4d4039f4302d5f7bfb9c4a4614c83e42ed092d1ef8e35bcd75ea67bf35262c35b910f489f021c49bc2e43ac9c035e25cdcd9a8863d16bef7c32e7ab4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cde78c4fe44e2db01ba4d70c02d0da61df63707e5acc082a072e552c898a954921dddd51c83c9b2db262258f2721a2a64ff631e74dd4890de86e9e488a2c02b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f776699e499065cab99e017d280e5d2c917236b846934f3dcb446f224d2027922b7c40b4362afdff31e7792cc471704809e99ab0227cb4096508f98e9a63bdb"} 15:41:59 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:59 INFO - Copying logs to upload dir... 15:41:59 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.136663 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-09 15:41:58.959974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 15:41:58.964377) ========= 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=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 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/307240d3dfdf277ed22f2867099b566c177d4ddff3df44a81ef3f0ecf80921a521fdcba406dafd2915bbab83bb63204631a35979d239401467ca18b3cd64e023", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d50d49b4d4039f4302d5f7bfb9c4a4614c83e42ed092d1ef8e35bcd75ea67bf35262c35b910f489f021c49bc2e43ac9c035e25cdcd9a8863d16bef7c32e7ab4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cde78c4fe44e2db01ba4d70c02d0da61df63707e5acc082a072e552c898a954921dddd51c83c9b2db262258f2721a2a64ff631e74dd4890de86e9e488a2c02b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f776699e499065cab99e017d280e5d2c917236b846934f3dcb446f224d2027922b7c40b4362afdff31e7792cc471704809e99ab0227cb4096508f98e9a63bdb"} build_url:https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/MA-3vqX9SCK7dglRp0vY9Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/307240d3dfdf277ed22f2867099b566c177d4ddff3df44a81ef3f0ecf80921a521fdcba406dafd2915bbab83bb63204631a35979d239401467ca18b3cd64e023", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d50d49b4d4039f4302d5f7bfb9c4a4614c83e42ed092d1ef8e35bcd75ea67bf35262c35b910f489f021c49bc2e43ac9c035e25cdcd9a8863d16bef7c32e7ab4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cde78c4fe44e2db01ba4d70c02d0da61df63707e5acc082a072e552c898a954921dddd51c83c9b2db262258f2721a2a64ff631e74dd4890de86e9e488a2c02b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f776699e499065cab99e017d280e5d2c917236b846934f3dcb446f224d2027922b7c40b4362afdff31e7792cc471704809e99ab0227cb4096508f98e9a63bdb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 15:41:58.992387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:41:58.992712) ========= 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=745a4373a2a16df560f216e000000264-1504995672.635366-2120729365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:41:59.078941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 15:41:59.079256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 15:41:59.079580) ========= ========= Total master_lag: 0.25 =========