builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1504997594.87 results: success (0) revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:14.865782) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:14.866305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:14.866637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:14.884562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:14.884938) ========= 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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 15:53:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-09-09 15:53:14 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:15.014061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:15.014376) ========= 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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014423 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:15.064187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 15:53:15.064526) ========= 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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 15:53:15,081 truncating revision to first 12 chars 2017-09-09 15:53:15,081 Setting DEBUG logging. 2017-09-09 15:53:15,082 attempt 1/10 2017-09-09 15:53:15,082 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:53:16,233 unpacking tar archive at: mozilla-central-d53ba311ca2f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.500009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 15:53:16.581534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:16.581954) ========= script_repo_revision: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:16.582356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:16.582622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 15:53:16.595318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-09 15:53:16.595635) ========= /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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:16 INFO - MultiFileLogger online at 20170909 15:53:16 in /builds/slave/test 15:53:16 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:53:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:16 INFO - {'append_to_log': False, 15:53:16 INFO - 'base_work_dir': '/builds/slave/test', 15:53:16 INFO - 'blob_upload_branch': 'Firefox', 15:53:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:16 INFO - 'branch': 'Firefox', 15:53:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:16 INFO - 'code_coverage': False, 15:53:16 INFO - 'config_files': ('talos/linux_config.py',), 15:53:16 INFO - 'default_actions': ('clobber', 15:53:16 INFO - 'read-buildbot-config', 15:53:16 INFO - 'download-and-extract', 15:53:16 INFO - 'populate-webroot', 15:53:16 INFO - 'create-virtualenv', 15:53:16 INFO - 'install', 15:53:16 INFO - 'setup-mitmproxy', 15:53:16 INFO - 'run-tests'), 15:53:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:16 INFO - 'disable_ccov_upload': False, 15:53:16 INFO - 'disable_stylo': False, 15:53:16 INFO - 'download_minidump_stackwalk': True, 15:53:16 INFO - 'download_symbols': 'ondemand', 15:53:16 INFO - 'enable_stylo': False, 15:53:16 INFO - 'enable_webrender': False, 15:53:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:53:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:16 INFO - 'gecko_profile': False, 15:53:16 INFO - 'gecko_profile_interval': 0, 15:53:16 INFO - 'installer_path': 'installer.exe', 15:53:16 INFO - 'log_level': 'info', 15:53:16 INFO - 'log_name': 'talos', 15:53:16 INFO - 'log_to_console': True, 15:53:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:16 INFO - 'opt_config_files': (), 15:53:16 INFO - 'pip_index': False, 15:53:16 INFO - 'suite': 'dromaeojs-e10s', 15:53:16 INFO - 'system_bits': '32', 15:53:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:16 INFO - 'title': 'talos-linux64-ix-022', 15:53:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:16 INFO - 'use_talos_json': True, 15:53:16 INFO - 'verify': 'False', 15:53:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:16 INFO - 'work_dir': 'build'} 15:53:16 INFO - [mozharness: 2017-09-09 22:53:16.756388Z] Running clobber step. 15:53:16 INFO - Running pre-action listener: _resource_record_pre_action 15:53:16 INFO - Running main action method: clobber 15:53:16 INFO - rmtree: /builds/slave/test/build 15:53:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:18 INFO - Running post-action listener: _resource_record_post_action 15:53:18 INFO - [mozharness: 2017-09-09 22:53:18.286413Z] Finished clobber step (success) 15:53:18 INFO - [mozharness: 2017-09-09 22:53:18.286511Z] Running read-buildbot-config step. 15:53:18 INFO - Running pre-action listener: _resource_record_pre_action 15:53:18 INFO - Running main action method: read_buildbot_config 15:53:18 INFO - Using buildbot properties: 15:53:18 INFO - { 15:53:18 INFO - "project": "", 15:53:18 INFO - "product": "firefox", 15:53:18 INFO - "who": "archaeopteryx@coole-files.de", 15:53:18 INFO - "installer_path": "public/build/target.tar.bz2", 15:53:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:53:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:53:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:53:18 INFO - "stage_platform": "linux64-pgo", 15:53:18 INFO - "basedir": "/builds/slave/test", 15:53:18 INFO - "buildnumber": 172, 15:53:18 INFO - "platform": "ubuntu64_hw", 15:53:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:53:18 INFO - "slavebuilddir": "test", 15:53:18 INFO - "taskId": "cKk6UOvTQsmI5vB_LtCLLg", 15:53:18 INFO - "branch": "mozilla-central", 15:53:18 INFO - "script_repo_revision": "production", 15:53:18 INFO - "revision": "d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6", 15:53:18 INFO - "slavename": "talos-linux64-ix-022", 15:53:18 INFO - "repo_path": "mozilla-central" 15:53:18 INFO - } 15:53:18 INFO - Finding installer, test and symbols from parent task. 15:53:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cKk6UOvTQsmI5vB_LtCLLg'}, attempt #1 15:53:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cKk6UOvTQsmI5vB_LtCLLg'}, attempt #1 15:53:19 INFO - Task dependencies: NDWkOfmBRomD9ih9HcxR6A 15:53:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A'}, attempt #1 15:53:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 15:53:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.test_packages.json 15:53:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.crashreporter-symbols.zip 15:53:19 INFO - Running post-action listener: _resource_record_post_action 15:53:19 INFO - [mozharness: 2017-09-09 22:53:19.666981Z] Finished read-buildbot-config step (success) 15:53:19 INFO - [mozharness: 2017-09-09 22:53:19.667287Z] Running download-and-extract step. 15:53:19 INFO - Running pre-action listener: _resource_record_pre_action 15:53:19 INFO - Running main action method: download_and_extract 15:53:19 INFO - mkdir: /builds/slave/test/build/tests 15:53:19 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:53:19 INFO - trying https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.test_packages.json 15:53:19 INFO - Downloading https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:53:20 INFO - Downloaded 989 bytes. 15:53:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:53:20 INFO - Using the following test package requirements: 15:53:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:53:20 INFO - u'common': [u'target.common.tests.zip'], 15:53:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:53:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:53:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:53:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:53:20 INFO - u'mozbase': [u'target.common.tests.zip'], 15:53:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:53:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:53:20 INFO - u'web-platform': [u'target.common.tests.zip', 15:53:20 INFO - u'target.web-platform.tests.tar.gz'], 15:53:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:53:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:53:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.common.tests.zip 15:53:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:53:20 INFO - Fetch https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.common.tests.zip into memory 15:53:21 INFO - Content-Length response header: 55692024 15:53:21 INFO - Bytes received: 55692024 15:53:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.talos.tests.zip 15:53:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:53:32 INFO - Fetch https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.talos.tests.zip into memory 15:53:33 INFO - Content-Length response header: 14497963 15:53:33 INFO - Bytes received: 14497963 15:53: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:53:33 INFO - trying https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 15:53:33 INFO - Downloading https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:53:34 INFO - Downloaded 63684512 bytes. 15:53:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 15:53:34 INFO - mkdir: /builds/slave/test/properties 15:53:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:34 INFO - Contents: 15:53:34 INFO - build_url:https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 15:53:34 INFO - Running post-action listener: _resource_record_post_action 15:53:34 INFO - Running post-action listener: find_tests_for_verification 15:53:34 INFO - Running post-action listener: set_extra_try_arguments 15:53:34 INFO - [mozharness: 2017-09-09 22:53:34.819156Z] Finished download-and-extract step (success) 15:53:34 INFO - [mozharness: 2017-09-09 22:53:34.819389Z] Running populate-webroot step. 15:53:34 INFO - Running pre-action listener: _resource_record_pre_action 15:53:34 INFO - Running main action method: populate_webroot 15:53:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:34 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['tresize', 15:53:34 INFO - 'tcanvasmark']}, 15:53:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:34 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['dromaeo_css', 15:53:34 INFO - 'kraken']}, 15:53:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:34 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'tests': ['damp', 'tps']}, 15:53:34 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['damp', 'tps']}, 15:53:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:34 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['dromaeo_dom']}, 15:53:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:53:34 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['basic_compositor_video', 15:53:34 INFO - 'glvideo']}, 15:53:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:53:34 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['ts_paint_webext', 15:53:34 INFO - 'tp5o_webext']}, 15:53:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:34 INFO - 'ts_paint', 15:53:34 INFO - 'tpaint', 15:53:34 INFO - 'sessionrestore', 15:53:34 INFO - 'sessionrestore_many_windows', 15:53:34 INFO - 'sessionrestore_no_auto_restore', 15:53:34 INFO - 'tabpaint']}, 15:53:34 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['a11yr', 15:53:34 INFO - 'ts_paint', 15:53:34 INFO - 'tpaint', 15:53:34 INFO - 'sessionrestore', 15:53:34 INFO - 'sessionrestore_many_windows', 15:53:34 INFO - 'sessionrestore_no_auto_restore', 15:53:34 INFO - 'tabpaint']}, 15:53:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:53:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:53:34 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['bloom_basic_singleton']}, 15:53:34 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['bloom_basic']}, 15:53:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:34 INFO - 'tsvgr_opacity', 15:53:34 INFO - 'tart', 15:53:34 INFO - 'tscrollx', 15:53:34 INFO - 'tsvg_static']}, 15:53:34 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['tsvgx', 15:53:34 INFO - 'tsvgr_opacity', 15:53:34 INFO - 'tart', 15:53:34 INFO - 'tscrollx', 15:53:34 INFO - 'tsvg_static']}, 15:53:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:53:34 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo'], 15:53:34 INFO - 'tests': ['tp5o']}, 15:53:34 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:34 INFO - 'talos_options': ['--mitmproxy', 15:53:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:34 INFO - '--firstNonBlankPaint'], 15:53:34 INFO - 'tests': ['tp6_google', 15:53:34 INFO - 'tp6_youtube', 15:53:34 INFO - 'tp6_amazon', 15:53:34 INFO - 'tp6_facebook']}, 15:53:34 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo', 15:53:34 INFO - '--mitmproxy', 15:53:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:34 INFO - '--firstNonBlankPaint'], 15:53:34 INFO - 'tests': ['tp6_google', 15:53:34 INFO - 'tp6_youtube', 15:53:34 INFO - 'tp6_amazon', 15:53:34 INFO - 'tp6_facebook']}, 15:53:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:34 INFO - 'talos_options': ['--stylo-threads=1', 15:53:34 INFO - '--mitmproxy', 15:53:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:34 INFO - '--firstNonBlankPaint'], 15:53:34 INFO - 'tests': ['tp6_google', 15:53:34 INFO - 'tp6_youtube', 15:53:34 INFO - 'tp6_amazon', 15:53:34 INFO - 'tp6_facebook']}, 15:53:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--xperf_path', 15:53:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:34 INFO - 'tests': ['tp5n']}, 15:53:34 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:34 INFO - 'talos_options': ['--disable-stylo', 15:53:34 INFO - '--xperf_path', 15:53:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:34 INFO - 'tests': ['tp5n']}}} 15:53:34 INFO - Running post-action listener: _resource_record_post_action 15:53:34 INFO - [mozharness: 2017-09-09 22:53:34.845850Z] Finished populate-webroot step (success) 15:53:34 INFO - [mozharness: 2017-09-09 22:53:34.845945Z] Running create-virtualenv step. 15:53:34 INFO - Running pre-action listener: _resource_record_pre_action 15:53:34 INFO - Running main action method: create_virtualenv 15:53:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:34 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:34 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:53:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:53:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:36 INFO - Installing pip...............done. 15:53:36 INFO - Return code: 0 15:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:53:36 INFO - Reading from file tmpfile_stdout 15:53:36 INFO - Output received: 15:53:36 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:53:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:53:36 INFO - Using env: {'DISPLAY': ':0', 15:53:36 INFO - 'HOME': '/home/cltbld', 15:53:36 INFO - 'LANG': 'en_US.UTF-8', 15:53:36 INFO - 'LANGUAGE': 'en_US:en', 15:53:36 INFO - 'LOGNAME': 'cltbld', 15:53:36 INFO - 'MAIL': '/var/mail/cltbld', 15:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:36 INFO - 'MOZ_NO_REMOTE': '1', 15:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:36 INFO - 'NO_EM_RESTART': '1', 15:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:36 INFO - 'PWD': '/builds/slave/test', 15:53:36 INFO - 'SHELL': '/bin/bash', 15:53:36 INFO - 'SHLVL': '1', 15:53:36 INFO - 'TERM': 'linux', 15:53:36 INFO - 'TMOUT': '86400', 15:53:36 INFO - 'USER': 'cltbld', 15:53:36 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:36 INFO - '_': '/tools/buildbot/bin/python'} 15:53:37 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:53:37 INFO - Downloading/unpacking pip>=1.5 15:53:37 INFO - Running setup.py egg_info for package pip 15:53:37 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:37 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:37 INFO - Installing collected packages: pip 15:53:37 INFO - Found existing installation: pip 1.1 15:53:37 INFO - Uninstalling pip: 15:53:37 INFO - Successfully uninstalled pip 15:53:37 INFO - Running setup.py install for pip 15:53:37 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:37 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:37 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:53:37 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:53:37 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:53:37 INFO - Successfully installed pip 15:53:37 INFO - Cleaning up... 15:53:37 INFO - Return code: 0 15:53:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53: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:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53: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', '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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:53: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 psutil>=3.1.1 15:53:37 INFO - Using env: {'DISPLAY': ':0', 15:53:37 INFO - 'HOME': '/home/cltbld', 15:53:37 INFO - 'LANG': 'en_US.UTF-8', 15:53:37 INFO - 'LANGUAGE': 'en_US:en', 15:53:37 INFO - 'LOGNAME': 'cltbld', 15:53:37 INFO - 'MAIL': '/var/mail/cltbld', 15:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:37 INFO - 'MOZ_NO_REMOTE': '1', 15:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:37 INFO - 'NO_EM_RESTART': '1', 15:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:37 INFO - 'PWD': '/builds/slave/test', 15:53:37 INFO - 'SHELL': '/bin/bash', 15:53:37 INFO - 'SHLVL': '1', 15:53:37 INFO - 'TERM': 'linux', 15:53:37 INFO - 'TMOUT': '86400', 15:53:37 INFO - 'USER': 'cltbld', 15:53:37 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:37 INFO - '_': '/tools/buildbot/bin/python'} 15:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:37 INFO - Downloading/unpacking psutil>=3.1.1 15:53: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:53: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:53: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:53: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:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:38 INFO - Installing collected packages: psutil 15:53:38 INFO - Running setup.py install for psutil 15:53:38 INFO - building 'psutil._psutil_linux' extension 15:53:38 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:53:39 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:53:39 INFO - building 'psutil._psutil_posix' extension 15:53:39 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:53:39 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:53:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:39 INFO - Successfully installed psutil 15:53:39 INFO - Cleaning up... 15:53:39 INFO - Return code: 0 15:53:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53: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:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53: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 mozsystemmonitor==0.3 15:53:39 INFO - Using env: {'DISPLAY': ':0', 15:53:39 INFO - 'HOME': '/home/cltbld', 15:53:39 INFO - 'LANG': 'en_US.UTF-8', 15:53:39 INFO - 'LANGUAGE': 'en_US:en', 15:53:39 INFO - 'LOGNAME': 'cltbld', 15:53:39 INFO - 'MAIL': '/var/mail/cltbld', 15:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:39 INFO - 'MOZ_NO_REMOTE': '1', 15:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:39 INFO - 'NO_EM_RESTART': '1', 15:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:39 INFO - 'PWD': '/builds/slave/test', 15:53:39 INFO - 'SHELL': '/bin/bash', 15:53:39 INFO - 'SHLVL': '1', 15:53:39 INFO - 'TERM': 'linux', 15:53:39 INFO - 'TMOUT': '86400', 15:53:39 INFO - 'USER': 'cltbld', 15:53:39 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:39 INFO - '_': '/tools/buildbot/bin/python'} 15:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:39 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:53:39 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:53:39 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:53:39 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:53:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:40 INFO - Installing collected packages: mozsystemmonitor 15:53:40 INFO - Running setup.py install for mozsystemmonitor 15:53:41 INFO - Successfully installed mozsystemmonitor 15:53:41 INFO - Cleaning up... 15:53:41 INFO - Return code: 0 15:53:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:41 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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:41 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:53:41 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:53:41 INFO - Using env: {'DISPLAY': ':0', 15:53:41 INFO - 'HOME': '/home/cltbld', 15:53:41 INFO - 'LANG': 'en_US.UTF-8', 15:53:41 INFO - 'LANGUAGE': 'en_US:en', 15:53:41 INFO - 'LOGNAME': 'cltbld', 15:53:41 INFO - 'MAIL': '/var/mail/cltbld', 15:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:41 INFO - 'MOZ_NO_REMOTE': '1', 15:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:41 INFO - 'NO_EM_RESTART': '1', 15:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:41 INFO - 'PWD': '/builds/slave/test', 15:53:41 INFO - 'SHELL': '/bin/bash', 15:53:41 INFO - 'SHLVL': '1', 15:53:41 INFO - 'TERM': 'linux', 15:53:41 INFO - 'TMOUT': '86400', 15:53:41 INFO - 'USER': 'cltbld', 15:53:41 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:41 INFO - '_': '/tools/buildbot/bin/python'} 15:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:43 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:44 INFO - warning: no files found matching '*.txt' 15:53:44 INFO - no previously-included directories found matching 'build' 15:53:44 INFO - no previously-included directories found matching 'dist' 15:53:44 INFO - no previously-included directories found matching '.git*' 15:53:44 INFO - Installing collected packages: jsonschema, functools32 15:53:44 INFO - Running setup.py install for functools32 15:53:44 INFO - warning: no files found matching '*.txt' 15:53:44 INFO - no previously-included directories found matching 'build' 15:53:44 INFO - no previously-included directories found matching 'dist' 15:53:44 INFO - no previously-included directories found matching '.git*' 15:53:44 INFO - Successfully installed jsonschema functools32 15:53:44 INFO - Cleaning up... 15:53:44 INFO - Return code: 0 15:53:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:44 INFO - Using env: {'DISPLAY': ':0', 15:53:44 INFO - 'HOME': '/home/cltbld', 15:53:44 INFO - 'LANG': 'en_US.UTF-8', 15:53:44 INFO - 'LANGUAGE': 'en_US:en', 15:53:44 INFO - 'LOGNAME': 'cltbld', 15:53:44 INFO - 'MAIL': '/var/mail/cltbld', 15:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:44 INFO - 'MOZ_NO_REMOTE': '1', 15:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:44 INFO - 'NO_EM_RESTART': '1', 15:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:44 INFO - 'PWD': '/builds/slave/test', 15:53:44 INFO - 'SHELL': '/bin/bash', 15:53:44 INFO - 'SHLVL': '1', 15:53:44 INFO - 'TERM': 'linux', 15:53:44 INFO - 'TMOUT': '86400', 15:53:44 INFO - 'USER': 'cltbld', 15:53:44 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:44 INFO - '_': '/tools/buildbot/bin/python'} 15:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:44 INFO - Cleaning up... 15:53:44 INFO - Return code: 0 15:53:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:44 INFO - Using env: {'DISPLAY': ':0', 15:53:44 INFO - 'HOME': '/home/cltbld', 15:53:44 INFO - 'LANG': 'en_US.UTF-8', 15:53:44 INFO - 'LANGUAGE': 'en_US:en', 15:53:44 INFO - 'LOGNAME': 'cltbld', 15:53:44 INFO - 'MAIL': '/var/mail/cltbld', 15:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:44 INFO - 'MOZ_NO_REMOTE': '1', 15:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:44 INFO - 'NO_EM_RESTART': '1', 15:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:44 INFO - 'PWD': '/builds/slave/test', 15:53:44 INFO - 'SHELL': '/bin/bash', 15:53:44 INFO - 'SHLVL': '1', 15:53:44 INFO - 'TERM': 'linux', 15:53:44 INFO - 'TMOUT': '86400', 15:53:44 INFO - 'USER': 'cltbld', 15:53:44 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:44 INFO - '_': '/tools/buildbot/bin/python'} 15:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:53: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:53: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:53: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:53: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:53:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53: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:53: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:53: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:53: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:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:46 INFO - Downloading docopt-0.6.1.tar.gz 15:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:46 INFO - Running setup.py install for blobuploader 15:53:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:46 INFO - Running setup.py install for requests 15:53:46 INFO - Running setup.py install for docopt 15:53:46 INFO - Successfully installed blobuploader requests docopt 15:53:46 INFO - Cleaning up... 15:53:47 INFO - Return code: 0 15:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:47 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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:47 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:53:47 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:53:47 INFO - Using env: {'DISPLAY': ':0', 15:53:47 INFO - 'HOME': '/home/cltbld', 15:53:47 INFO - 'LANG': 'en_US.UTF-8', 15:53:47 INFO - 'LANGUAGE': 'en_US:en', 15:53:47 INFO - 'LOGNAME': 'cltbld', 15:53:47 INFO - 'MAIL': '/var/mail/cltbld', 15:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:47 INFO - 'MOZ_NO_REMOTE': '1', 15:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:47 INFO - 'NO_EM_RESTART': '1', 15:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:47 INFO - 'PWD': '/builds/slave/test', 15:53:47 INFO - 'SHELL': '/bin/bash', 15:53:47 INFO - 'SHLVL': '1', 15:53:47 INFO - 'TERM': 'linux', 15:53:47 INFO - 'TMOUT': '86400', 15:53:47 INFO - 'USER': 'cltbld', 15:53:47 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:47 INFO - '_': '/tools/buildbot/bin/python'} 15:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:47 INFO - Running setup.py (path:/tmp/pip-Jm512K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:47 INFO - Running setup.py (path:/tmp/pip-HpORFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:47 INFO - Running setup.py (path:/tmp/pip-AUGvfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:47 INFO - Running setup.py (path:/tmp/pip-Oi922t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:47 INFO - Running setup.py (path:/tmp/pip-rWzzXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:47 INFO - Running setup.py (path:/tmp/pip-ym_dAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:47 INFO - Running setup.py (path:/tmp/pip-FYzM71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:47 INFO - Running setup.py (path:/tmp/pip-XgB00s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:47 INFO - Running setup.py (path:/tmp/pip-MZnOYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:47 INFO - Running setup.py (path:/tmp/pip-KETYFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:47 INFO - Running setup.py (path:/tmp/pip-ytPs9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:48 INFO - Running setup.py (path:/tmp/pip-Bwjgb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:48 INFO - Running setup.py (path:/tmp/pip-l_S3eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:48 INFO - Running setup.py (path:/tmp/pip-Qyb_EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:48 INFO - Running setup.py (path:/tmp/pip-GFnaQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:48 INFO - Running setup.py (path:/tmp/pip-eVvFWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:48 INFO - Running setup.py (path:/tmp/pip-xeMFda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:48 INFO - Running setup.py install for manifestparser 15:53:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:48 INFO - Running setup.py install for mozcrash 15:53:48 INFO - Running setup.py install for mozdebug 15:53:48 INFO - Running setup.py install for mozdevice 15:53:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:48 INFO - Running setup.py install for mozfile 15:53:48 INFO - Running setup.py install for mozhttpd 15:53:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozinfo 15:53:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozInstall 15:53:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozleak 15:53:49 INFO - Running setup.py install for mozlog 15:53:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for moznetwork 15:53:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozprocess 15:53:49 INFO - Running setup.py install for mozprofile 15:53:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozrunner 15:53:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:49 INFO - Running setup.py install for mozscreenshot 15:53:49 INFO - Running setup.py install for moztest 15:53:50 INFO - Running setup.py install for mozversion 15:53:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:50 INFO - Cleaning up... 15:53:50 INFO - Return code: 0 15:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:50 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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:50 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:53:50 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:53:50 INFO - Using env: {'DISPLAY': ':0', 15:53:50 INFO - 'HOME': '/home/cltbld', 15:53:50 INFO - 'LANG': 'en_US.UTF-8', 15:53:50 INFO - 'LANGUAGE': 'en_US:en', 15:53:50 INFO - 'LOGNAME': 'cltbld', 15:53:50 INFO - 'MAIL': '/var/mail/cltbld', 15:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:50 INFO - 'MOZ_NO_REMOTE': '1', 15:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:50 INFO - 'NO_EM_RESTART': '1', 15:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:50 INFO - 'PWD': '/builds/slave/test', 15:53:50 INFO - 'SHELL': '/bin/bash', 15:53:50 INFO - 'SHLVL': '1', 15:53:50 INFO - 'TERM': 'linux', 15:53:50 INFO - 'TMOUT': '86400', 15:53:50 INFO - 'USER': 'cltbld', 15:53:50 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:50 INFO - '_': '/tools/buildbot/bin/python'} 15:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:50 INFO - Running setup.py (path:/tmp/pip-hUrUK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:50 INFO - Running setup.py (path:/tmp/pip-a5IRqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:50 INFO - Running setup.py (path:/tmp/pip-D0FSJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:50 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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:50 INFO - Running setup.py (path:/tmp/pip-q7s0Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53: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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:50 INFO - Running setup.py (path:/tmp/pip-IzNNnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53: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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:50 INFO - Running setup.py (path:/tmp/pip-xgSNHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53: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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:50 INFO - Running setup.py (path:/tmp/pip-UtodIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53: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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:50 INFO - Running setup.py (path:/tmp/pip-MJp6qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53: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:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:50 INFO - Running setup.py (path:/tmp/pip-vEy3N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:51 INFO - Running setup.py (path:/tmp/pip-DfMcIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:51 INFO - Running setup.py (path:/tmp/pip-ReIIyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:51 INFO - Running setup.py (path:/tmp/pip-35doMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:51 INFO - Running setup.py (path:/tmp/pip-QSsVdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:51 INFO - Running setup.py (path:/tmp/pip-dOLdEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:51 INFO - Running setup.py (path:/tmp/pip-mf1bRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:51 INFO - Running setup.py (path:/tmp/pip-OIatEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:51 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:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:51 INFO - Running setup.py (path:/tmp/pip-RcSVYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53: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:53: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:53: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:53: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:53: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:53: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:53: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:53:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53: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:53: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:53: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:53: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:53:52 INFO - Downloading blessings-1.6.tar.gz 15:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:52 INFO - Installing collected packages: blessings 15:53:52 INFO - Running setup.py install for blessings 15:53:52 INFO - Successfully installed blessings 15:53:52 INFO - Cleaning up... 15:53:52 INFO - Return code: 0 15:53:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:53 INFO - Reading from file tmpfile_stdout 15:53:53 INFO - Current package versions: 15:53:53 INFO - argparse == 1.2.1 15:53:53 INFO - blessings == 1.6 15:53:53 INFO - blobuploader == 1.2.4 15:53:53 INFO - docopt == 0.6.1 15:53:53 INFO - functools32 == 3.2.3-2 15:53:53 INFO - jsonschema == 2.5.1 15:53:53 INFO - manifestparser == 1.1 15:53:53 INFO - mozInstall == 1.13 15:53:53 INFO - mozcrash == 1.0 15:53:53 INFO - mozdebug == 0.1 15:53:53 INFO - mozdevice == 0.51 15:53:53 INFO - mozfile == 1.2 15:53:53 INFO - mozhttpd == 0.7 15:53:53 INFO - mozinfo == 0.10 15:53:53 INFO - mozleak == 0.1 15:53:53 INFO - mozlog == 3.5 15:53:53 INFO - moznetwork == 0.27 15:53:53 INFO - mozprocess == 0.25 15:53:53 INFO - mozprofile == 0.28 15:53:53 INFO - mozrunner == 6.13 15:53:53 INFO - mozscreenshot == 0.1 15:53:53 INFO - mozsystemmonitor == 0.3 15:53:53 INFO - moztest == 0.8 15:53:53 INFO - mozversion == 1.4 15:53:53 INFO - psutil == 3.1.1 15:53:53 INFO - requests == 1.2.3 15:53:53 INFO - wsgiref == 0.1.2 15:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:53 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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:53 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:53:53 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:53:53 INFO - Using env: {'DISPLAY': ':0', 15:53:53 INFO - 'HOME': '/home/cltbld', 15:53:53 INFO - 'LANG': 'en_US.UTF-8', 15:53:53 INFO - 'LANGUAGE': 'en_US:en', 15:53:53 INFO - 'LOGNAME': 'cltbld', 15:53:53 INFO - 'MAIL': '/var/mail/cltbld', 15:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:53 INFO - 'MOZ_NO_REMOTE': '1', 15:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:53 INFO - 'NO_EM_RESTART': '1', 15:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:53 INFO - 'PWD': '/builds/slave/test', 15:53:53 INFO - 'SHELL': '/bin/bash', 15:53:53 INFO - 'SHLVL': '1', 15:53:53 INFO - 'TERM': 'linux', 15:53:53 INFO - 'TMOUT': '86400', 15:53:53 INFO - 'USER': 'cltbld', 15:53:53 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:53 INFO - '_': '/tools/buildbot/bin/python'} 15:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 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:53:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:53:54 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:53:54 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:53:54 INFO - Installing collected packages: simplejson 15:53:54 INFO - Running setup.py install for simplejson 15:53:54 INFO - building 'simplejson._speedups' extension 15:53: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:53:55 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:53:55 INFO - Successfully installed simplejson 15:53:55 INFO - Cleaning up... 15:53:55 INFO - Return code: 0 15:53:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:55 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 0x17351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, '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': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', '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:53:55 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:53:55 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:53:55 INFO - Using env: {'DISPLAY': ':0', 15:53:55 INFO - 'HOME': '/home/cltbld', 15:53:55 INFO - 'LANG': 'en_US.UTF-8', 15:53:55 INFO - 'LANGUAGE': 'en_US:en', 15:53:55 INFO - 'LOGNAME': 'cltbld', 15:53:55 INFO - 'MAIL': '/var/mail/cltbld', 15:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:55 INFO - 'MOZ_NO_REMOTE': '1', 15:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:55 INFO - 'NO_EM_RESTART': '1', 15:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:55 INFO - 'PWD': '/builds/slave/test', 15:53:55 INFO - 'SHELL': '/bin/bash', 15:53:55 INFO - 'SHLVL': '1', 15:53:55 INFO - 'TERM': 'linux', 15:53:55 INFO - 'TMOUT': '86400', 15:53:55 INFO - 'USER': 'cltbld', 15:53:55 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:55 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:55 INFO - Cleaning up... 15:53:55 INFO - Return code: 0 15:53:55 INFO - Running post-action listener: _resource_record_post_action 15:53:55 INFO - Running post-action listener: _start_resource_monitoring 15:53:55 INFO - Starting resource monitoring. 15:53:55 INFO - [mozharness: 2017-09-09 22:53:55.884545Z] Finished create-virtualenv step (success) 15:53:55 INFO - [mozharness: 2017-09-09 22:53:55.885014Z] Running install step. 15:53:55 INFO - Running pre-action listener: _resource_record_pre_action 15:53:55 INFO - Running main action method: install 15:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:56 INFO - Reading from file tmpfile_stdout 15:53:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:56 INFO - Reading from file tmpfile_stdout 15:53:56 INFO - Output received: 15:53:56 INFO - Usage: mozinstall [options] installer 15:53:56 INFO - Options: 15:53:56 INFO - -h, --help show this help message and exit 15:53:56 INFO - -d DEST, --destination=DEST 15:53:56 INFO - Directory to install application into. [default: 15:53:56 INFO - "/builds/slave/test"] 15:53:56 INFO - --app=APP Application being installed. [default: firefox] 15:53:56 INFO - mkdir: /builds/slave/test/build/application 15:53:56 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:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:54:12 INFO - Reading from file tmpfile_stdout 15:54:12 INFO - Output received: 15:54:12 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:12 INFO - Running post-action listener: _resource_record_post_action 15:54:12 INFO - [mozharness: 2017-09-09 22:54:12.668767Z] Finished install step (success) 15:54:12 INFO - [mozharness: 2017-09-09 22:54:12.668915Z] Running setup-mitmproxy step. 15:54:12 INFO - Running pre-action listener: _resource_record_pre_action 15:54:12 INFO - Running main action method: setup_mitmproxy 15:54:12 INFO - Skipping: mitmproxy is not required 15:54:12 INFO - Running post-action listener: _resource_record_post_action 15:54:12 INFO - [mozharness: 2017-09-09 22:54:12.669606Z] Finished setup-mitmproxy step (success) 15:54:12 INFO - [mozharness: 2017-09-09 22:54:12.669741Z] Running run-tests step. 15:54:12 INFO - Running pre-action listener: _resource_record_pre_action 15:54:12 INFO - Running pre-action listener: _set_gcov_prefix 15:54:12 INFO - Running main action method: run_tests 15:54:12 WARNING - Try message not found. 15:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:12 INFO - Python 2.7.3 15:54:12 INFO - Return code: 0 15:54:12 INFO - grabbing minidump binary from tooltool 15:54: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:54: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 0x1aa5090>, '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 0x1aa5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54: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:54: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:54: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:54:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:12 INFO - Return code: 0 15:54:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:12 INFO - ENV: RUST_BACKTRACE is now full 15:54:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54: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/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:54: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/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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:54:12 INFO - Using env: {'DISPLAY': ':0', 15:54:12 INFO - 'HOME': '/home/cltbld', 15:54:12 INFO - 'LANG': 'en_US.UTF-8', 15:54:12 INFO - 'LANGUAGE': 'en_US:en', 15:54:12 INFO - 'LOGNAME': 'cltbld', 15:54:12 INFO - 'MAIL': '/var/mail/cltbld', 15:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:12 INFO - 'MOZ_NO_REMOTE': '1', 15:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:12 INFO - 'NO_EM_RESTART': '1', 15:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:12 INFO - 'PWD': '/builds/slave/test', 15:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:12 INFO - 'RUST_BACKTRACE': 'full', 15:54:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:12 INFO - 'SHELL': '/bin/bash', 15:54:12 INFO - 'SHLVL': '1', 15:54:12 INFO - 'TERM': 'linux', 15:54:12 INFO - 'TMOUT': '86400', 15:54:12 INFO - 'USER': 'cltbld', 15:54:12 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:12 INFO - '_': '/tools/buildbot/bin/python'} 15:54: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/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:54:13 INFO - mozversion application_buildid: 20170909213208 15:54:13 INFO - mozversion application_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:54:13 INFO - mozversion application_display_name: Nightly 15:54:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:13 INFO - mozversion application_name: Firefox 15:54:13 INFO - mozversion application_remotingname: firefox 15:54:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:54:13 INFO - mozversion application_vendor: Mozilla 15:54:13 INFO - mozversion application_version: 57.0a1 15:54:13 INFO - mozversion platform_buildid: 20170909213208 15:54:13 INFO - mozversion platform_changeset: d53ba311ca2f0c3d81d4a5e88a7449c18ec5e4b6 15:54:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:54:13 INFO - mozversion platform_version: 57.0a1 15:54:13 INFO - using testdate: 1504997653 15:54:13 INFO - actual date: 1504997653 15:54:13 INFO - starting webserver on 'localhost:47126' 15:54:13 INFO - SUITE-START | Running 2 tests 15:54:13 INFO - TEST-START | dromaeo_css 15:54:13 INFO - Initialising browser for dromaeo_css test... 15:54:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47126/getInfo.html -profile /tmp/tmpKWjmVo/profile 15:54:13 INFO - TEST-INFO | started process 21805 (/builds/slave/test/build/application/firefox/firefox http://localhost:47126/getInfo.html) 15:54:18 INFO - TEST-INFO | 21805: exit 0 15:54:18 INFO - Browser initialized. 15:54:18 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:18 INFO - Using env: {'DISPLAY': ':0', 15:54:18 INFO - 'HOME': '/home/cltbld', 15:54:18 INFO - 'JSGC_DISABLE_POISONING': '1', 15:54:18 INFO - 'LANG': 'en_US.UTF-8', 15:54:18 INFO - 'LANGUAGE': 'en_US:en', 15:54:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:54:18 INFO - 'LOGNAME': 'cltbld', 15:54:18 INFO - 'MAIL': '/var/mail/cltbld', 15:54:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:18 INFO - 'MOZ_CRASHREPORTER': '1', 15:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:54:18 INFO - 'MOZ_NO_REMOTE': '1', 15:54:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:18 INFO - 'NO_EM_RESTART': '1', 15:54:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:18 INFO - 'PWD': '/builds/slave/test', 15:54:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:18 INFO - 'RUST_BACKTRACE': 'full', 15:54:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:18 INFO - 'SHELL': '/bin/bash', 15:54:18 INFO - 'SHLVL': '1', 15:54:18 INFO - 'TERM': 'linux', 15:54:18 INFO - 'TMOUT': '86400', 15:54:18 INFO - 'USER': 'cltbld', 15:54:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 15:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:18 INFO - '_': '/tools/buildbot/bin/python'} 15:54:18 INFO - TEST-INFO | started process 22007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKWjmVo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:19 INFO - PID 22007 | 15:54:19 INFO - PID 22007 | (/builds/slave/test/build/application/firefox/firefox:22058): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:54:19 INFO - PID 22007 | 15:54:30 INFO - PID 22007 | RSS: Main: 164249600 15:54:30 INFO - PID 22007 | 15:57:26 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47126/tests/dromaeo/cssquery-ext.html) 15:57:28 INFO - PID 22007 | RSS: Main: 167821312 15:57:28 INFO - PID 22007 | 16:00:29 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-ext.html (next: http://localhost:47126/tests/dromaeo/cssquery-jquery.html) 16:00:30 INFO - PID 22007 | RSS: Main: 164634624 16:00:30 INFO - PID 22007 | 16:03:31 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47126/tests/dromaeo/cssquery-mootools.html) 16:03:32 INFO - PID 22007 | RSS: Main: 166793216 16:03:32 INFO - PID 22007 | 16:06:33 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47126/tests/dromaeo/cssquery-prototype.html) 16:06:34 INFO - PID 22007 | RSS: Main: 165068800 16:06:34 INFO - PID 22007 | 16:09:37 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47126/tests/dromaeo/cssquery-yui.html) 16:09:38 INFO - PID 22007 | RSS: Main: 166604800 16:09:38 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | Cycle 1(1): loaded http://localhost:47126/tests/dromaeo/cssquery-yui.html (next: http://localhost:47126/tests/dromaeo/cssquery-dojo.html) 16:12:39 INFO - PID 22007 | RSS: Main: 169328640 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | __start_tp_report 16:12:39 INFO - PID 22007 | _x_x_mozilla_page_load 16:12:39 INFO - PID 22007 | _x_x_mozilla_page_load_details 16:12:39 INFO - PID 22007 | |i|pagename|runs| 16:12:39 INFO - PID 22007 | |0;dojo.html;3866.903327416814;3869.516310461192;3887.4557561941333;3904.687624990001;3910.022494376404;6287.434130928215;6298.307186209513;6343;6391.744330226797;6448.193975753031;6398.680065996693;6401.071844582544;6432.871342573146;6531.216254049521;6547.050677651738;5725.227094342252;5734.598578099514;5751.597388182829;5772.105323674838;5807.303123625171;101.7852924302251;5683.54531637468;5767.971160144193;5846.795362162326;5912.349641539448;5742.339630942453;5750.856228594277;5804.767809287623;5819.854503637401;5832.708364581754;5734.541236701054;5737.88524229513;5803.912941305884;5811.535077193815;5817.331006934172;5753.194552762617;5755.740991655385;5828.446297601721;5837.328707198684;5840.415958404168;6312.589681670676;6371.362863713638;6476.093346931433;6483.384078512534;6504.837379065514;6801.35387138226;6876.724931002754;6909.1018167638385;6922.757703480354;7026.43788496919;6981.616011119387;7045.612491312976;7077.504574679774;7091.929080709178;7094.042304288907;6315.96842015787;6383.96808015957;6450.870982580369;6502.414782669535;6568.6058836469965;7036.261192574808;7160.319769621878;7178.174509931425;7206.783796486114;7261.927380726125;6742.662866856637;6773.593584384953;6870.3473170048765;6876.931230687729;6912.585244885323;6824.21521525021;6878.140232470942;6966.338197871194;6969.7909062728195;7033.331833475811;6801.5238933274195;6808.148981377328;6856.314368563104;6883.65581720912;6887.104676392037;6802.285759995229;6862.279460656559;6908.5509441886115;6940;6942.062821519131;5021.171506701354;5052.090623687698;5108.029474399852;5119.948800512022;5137.357830271216;4584.129015487047;4615.95384046162;4621.237495813153;4632;4643.8374656886845;6212.937870621236;6323.588966717149;6336.6831658416895;6350.6189628621505;6353.809385718436;6887.621180835102;6914.1702995639835;6930.792076237721;6959.512834101564;6990.335918087875;6289;6366.840828979312;6387.712552935036;6453.870922581522;6460.838479037968;5523.337199536001;5551.750171242304;5570.080936645408;5575.303087114111;5649.68926709035;7130.607816570138;7165.713371465083;7175.138983322035;7185.784426467214;7249.8550028999125;6799.354061364163;6930.064441300461;6976.5814051157095;6978.057962175041;6983.9650801745665;7116.252793456612;7124.536905101152;7212.954121652436;7218.27817218274;7228.674709637974;6774.525783195129;6842.623655698984;6853.314668533107;6881.41507971828;6882.139732533434;6938.895916561357;7015.6842942066705;7059.329363710439;7065.6820443081215;7068.257832927468;6494.837629059311;6558.704858281484;6719;6721.092652491851;6816.182058153054;6610.8347291318105;6636.83407914806;6646.83382915431;6648.335166483506;6674.132362792806;6573.211214654272;6580.80257592273;6584.868302633825;6597.835054123685;6600.504962127956;6607.7356905725155;6663.766768163091;6690.531662783558;6691.732330706912;6694.866102678016;6578.506612004215;6584.604923704593;6587.670616469061;6598.076269322395;6598.307177746459 16:12:39 INFO - PID 22007 | |1;ext.html;952.11453348386;963.580842333585;964.17562983649;965.2229954886318;965.5510187762688;40097.59902400979;44382.33426498605;44400.3339949901;44735;44798;42535.574644253546;42816.57183428165;42878;42902.35646465298;42943.78528107355;7540.698372065124;7651.961740191291;8153.510789352628;8345.290650294732;8349.123342049059;8154.918450815505;8260.29787468066;8267.545285009322;8268.049174344967;8270.297024752874;8265.338772898154;8331.583420828965;8336.416450848443;8337.416380853343;8340.457870238415;8220.753377398627;8268.131846156157;8275.586220689001;8300.958495207515;8305.792355191139;8078.434509584332;8128.268455839003;8129.512229266263;8219.794505137359;8223.671053157866;40234.59765402367;40407.595924040674;40419.59580404188;40426.79786601078;40440.19119617621;3767.1335592813534;3804.8668296609485;3806.3148633246005;3817.8472861085525;3821.312163810513;33401.3319733604;33424.49863252053;33498;33508.49737253943;33517.32965340679;5496.065668836308;5504.504594586467;5524.530414914737;5593.636413633101;5670.489655930986;205517;205749;206145;206489;207697;45921.31118033232;46760;51302.230466543035;51451.48548514467;51790.741046294526;54195;54978.725106375015;55327.72336138294;55398.16902746462;55460.445395545525;13675.931620341835;13790.65523361924;13814.930925345308;13844.653883652989;13852.238126902916;10734.624288149877;10754.73113172177;10762.031417172491;10773.299735517166;10776.407297598551;14951.850481495047;14960.401583936738;15029.248537573078;15044.924775376054;15153.166575838215;5913.852153696192;5963.522918166536;6011.48902343297;6021.0968354746265;6023.578349515579;1047.3244757131608;1107.1530279336314;1126.6563698072166;1130.2596799096605;1135.9488823002985;25789.61315580268;25799.097031603804;25869;25958.74041259601;26066.34834129162;1147.8909503597145;1196.8503937007874;1200.771853347861;1207.2756346192214;1221.7922953097996;13469.865301347058;13568.525101621395;13763.036587438783;13795.2412617305;13821.308934553232;299388;300876;301261;301262;302371;55708.44291557113;56240.15639765407;56302.43697563054;56323;56479;1450.1806479339139;1468.155810409019;1493.6191271225769;1505.902116362433;1509.9924500377429;24961.137241768785;24970.37574060663;25032.998680052595;25034.74965250324;25076.62385064262;40964.59035409727;41174.79412602918;41178.38232426456;41226.175476490906;41259.587404126774;236857;237422;237802;238743;239232;36756.264874702894;40367;40981.38527922024;41092.17815643611;41200.38199426951;48865;50465.24302135544;50894.982100358524;50967;51031.74484127704;36783.44824827576;37342.8132859334;37543.24913501769;37547.62452375441;37572.436413454365;37182.44226336661;37245.0688732773;37353;37634.24731505409;37969.4304585437;42122.78938605287;43118.56881431145;43238;43252.56747432611;43299.56700433081;35897.28205435824;36180.81909590435;36301.636983629825;36332;36795;25943.870280648476;26106.347341316618;27078.458430831666;27158.1852544424;27418 16:12:39 INFO - PID 22007 | |2;jquery.html;582.1093726598303;584.8011676030148;596.8275477262762;600.8077415227126;601.4376557918346;23216.76783232167;23926.76073239267;23938.16216432425;23981.76018239817;23987.640185397235;24233.63649545258;25353.746462535368;25963.221103366883;26102.08642697506;26165.73834261657;6475.222973243206;6534.640594767286;6562.770303039395;6563.245226798907;6570.93429065708;6315.3684631536935;6513.544051916368;6570.047343135243;6583.868322633544;6622;6513.316101809313;6514.739410423577;6535.215774107114;6535.575187612813;6539.6730163491875;6492.805215843532;6499.675016249193;6516.869662606721;6522.412982831521;6523.510736694767;6077.118817771398;6114.847128821771;6127.4791642710425;6129.877402451926;6133.693315334215;28842.567361489593;29741;29963.25091872699;30328;30429.543556846664;2222.0889435331596;2252.76345983671;2253.2001139595372;2253.4816992091746;2254.1434254983;20195.697064544045;20221.595568088702;20815.271465498634;21288.148474061018;21305.25431609886;2449.448874003353;2469.4814089041324;2512.7612876776675;2603.908863189798;2605.2965699261094;133605;139674;151375;158123.2093839535;158485;14884.883633727297;14937;14985.400583976736;15788.921055394649;15874.52376428709;24705;24708.38229044288;24766.38084047877;24776.628350574756;24895.751042489705;9719.125278724949;9962.800743985079;10031.949840250898;10095.242856785624;10103.949480252699;8745.825083498421;8760.211580957744;8895.955520222358;8908.688195913111;8955.059718729439;9456.959734429207;9619.344649033323;9755.219582433388;9826.557804898797;9998.80002399948;2720.469508445834;2756.6554180727408;2756.9310767230577;2796.9300767480568;2908.6800451950267;1006.5671761142779;1052.9157667386592;1055.8732952045805;1057.1806849691397;1076.4402510694395;20530.281440149523;21174.682379764316;21330.893345533485;21379.572408551743;21469.78530214709;1111.288775183883;1124.4995976790249;1128.2440764687678;1129.3901293301526;1134.7390100276982;11751.882481175078;11893.608733432471;11923.582674606347;11933.019507719222;11933.864836009112;532775;554669;591281;594386;617308;128041;129782;130356.3482182583;132034;134239;1089.2974031749477;1177.670252329349;1233.8272641830151;1251.8810712982252;1260.7730608490376;21367.593947780144;21658;21677.241296555178;21933.341999740034;21944.231951881608;61262.38737612745;61864;62195;62786.37213627988;64176;79018.20981790338;79057;79181.20818791738;79464.60267698625;79862.20137798548;14922.179280139262;15271.472852715084;15283.312250948957;15309.234538273264;15319.770203446735;23566;23591.528169436857;23881.283561493183;24015.639765403183;24107;19331.226750929804;19646.508837279183;19716.704249436556;19779.604407911473;19794.60410791805;16151.838481615034;16393.09837958924;16415.931409201647;16579.585510361856;17346.306147754454;19469;19890.403287901387;19967.700484492452;20161.193552257744;20174;15112.546623601309;15157.848421515644;15213.543593692208;15234.3906243749;15240.085594864344;19525.70711439358;19548.022598870284;19617.70573441371;19724.30964916221;19779.109940052444 16:12:39 INFO - PID 22007 | |3;mootools.html;1420.8437071922087;1461.7661174212128;1468.3686015013548;1487.353001444371;1488.2335597167453;16302.429414970478;17910.194041268143;17920;17933;17950.82049179508;17365.47903562892;17649.117544122775;17653.82346176541;17683.73474397885;17700.114994250267;2575.25317657879;2616.82990605611;2617.986910065447;2622.4755048990182;2629.0404002539126;2464.544059349017;2558.168595206556;2561.346856551577;2604.127617248224;2647.801414893881;2502.949941001179;2597.324695579144;2597.428565715549;2597.7791887689473;2603.0368763557512;2595.9610605840926;2605.7003444603924;2619.9607005894927;2634.459935713174;2635.9736402636017;2447.902083916641;2580.2646245820038;2612.2685648018587;2612.386089269039;2620.253227830059;16463;16601.086940218283;16751.16244187798;16792.66414671712;16841.747373789403;7814.804629884242;8080.797980050545;8087.636056377477;8092.433529652927;8092.676292948275;5297.549708274802;5391.946080539184;5480.424555421663;5500.779968801283;5529.557635389159;1942.0969249299144;1943.1838627776367;1945.3677554794606;1980.2178139634764;2003.9398818035336;29294.70705292941;29480.852595736884;29542.784291178246;29608.55587166194;29612.259693507618;6213.565050446426;6308.3060863305;6440.67796610177;6579.605223686594;6627.602343859384;19459.34595559365;19608.313709020116;19664.508387290432;19673.508162296057;19677.409677709693;7636.08366995964;7813.921860781433;7821.491603045783;7822.726204582812;7822.8435431291055;7094.787156385317;7162.283771622796;7162.46281528877;7197.316254955876;7199.964000179965;5242.423333433319;5371.194320851825;5400.972995134999;5427.48438898304;5435.320584926884;1421.0763004047246;1423.181670539444;1450.724362371146;1452.0924422236103;1455.660792071297;938.7981583959481;960.7550074730899;974.6491263145263;977.8484334928097;978.5596481583316;8442.746717598482;8559.914400856036;8581.828363432696;9714.951425242829;9734.026597340351;701.5755467941924;723.6888138100667;731.8902164675342;733.6991833348302;736.8010637127945;5773.364929857712;6003.919294527027;6155.384461553809;6211.65835879031;6303.086052522359;23705.288841334786;23786.64320035201;24545.754542454702;24786.380340491272;24796.752032479806;23256.65115023276;24403.877980609985;24456.877715611306;24530;24636.50726985486;12207.999999999822;12213.877861221274;12412.317322547347;12420.75158496825;12487.188332758524;9175.22010629104;9433.905660943303;9438.528073596155;9481;9530.95234523823;20836.270730524964;20854.687179692013;20919.163233470492;21112.68330975006;21213.787862121182;21908;21957.780422195574;21966;22105.557888842453;22127.55744885061;11635.301881887113;11668.066554675775;11719.472623731783;11836.171467997157;11889.583864564698;15252.77120843166;15388.076715397112;15449.150296733787;15458.690826183638;15483.5354939352;11885.108616853599;11911.523539058688;11982.940085299517;11998.820017699567;12147.635570932885;12406.25562466255;12445.439955202219;12564.246145231315;12636.115471916877;12694.936525317315;10054.34646747959;10222.846657299997;10235.48822558884;10289.125424339016;10296.485175741032;8380.580970951307;8432.620532075949;8436.746897593082;8444.873326900224;8554.401191916506;8378.664853405795;8423.789405264672;8540.871886921577;8574.699885503978;8595.570221488775 16:12:39 INFO - PID 22007 | |4;prototype.html;532.989340213196;540.3677697094399;558.3467343208446;561.7415988645223;576.4754073792849;6192.845178870531;6261.937380626198;6269.771067900029;6280.434760871521;6283;6147.139400483936;6183.536234782398;6183.81448556544;6197.597156184845;6201.255849298091;5006.599472042246;5033.521815427538;5034.974825125888;5050.368703912011;5078.7968481260705;5010.273510340999;5024.673396229252;5033.723145227029;5038.748062596874;5064.974675126619;4757.64317676174;4986.476419975905;5003.674761140533;5031.3207716958295;5071.366079240095;4817.759112044401;4827.324174615556;4838.758062096881;4860;4891.706497610119;4380.956190438087;4381.233284175257;4388.736675799462;4390.846320378803;4402.977985110086;6114.92988726971;6121.204243448323;6143.296949342275;6143.723532441051;6149.077638354238;5727.510847179721;5735.684537350444;5740.225069615591;5752.5110365618975;5760.222369980041;6568.408843204134;6581.605103693793;6609.735610575572;6610.504212184105;6619.602823830537;4735.313379559944;4876.561109500127;4885.364902562644;4904.779284932187;4909.68087074339;6732.629705366203;6793.150856142982;6833.6674348502065;6842.692078856414;6854.6229957352325;5122.462141475166;5135.075686376414;5140.948590514122;5144.536991670693;5150.613703972217;5191.273221748958;5193.740312984336;5205.947940520622;5206.140986737221;5210.583153347723;5735.4551317624755;5737.684427356536;5757.107648314518;5775.180818042303;5780.132980053026;6603.8113139635325;6637.1703537057865;6638.137042184485;6647.734090636417;6664.766733164316;1781.403229917966;1790.185465613143;1797.3170195325954;1802.6484835457222;1812.139233863904;1244.3404995352478;1275.4961790093048;1286.4403984266874;1293.8484748573776;1296.7925131978839;6196.225471816023;6198.566100372931;6203.348648391944;6245.750169993149;6252.718627661766;6539.313372095861;6634.170728658918;6661.566998145202;6662.133922590129;6702.932970670231;6119;6124.38756124384;6124.816255512342;6159.384061593805;6187.969060154671;3451.6030656474327;3479.6868281854754;3490.5462289902152;3517.66582174693;3521.1373213562842;6849.931500685029;6898.827529311808;6976.918577620477;6995.930040699528;7023.89464158038;6666.899996500057;6790.620050067679;6868.896966545506;6883.346082122191;6885.345892140239;6775.762848300285;6818.454523638097;6825.863482730417;6933.306669333027;6977.511574189758;6616.966915165393;6678.866422671422;6724.226713927961;6728.92337226061;6775.728970841308;6596.142501474777;6662.533622646368;6691;6694.430973367318;6718.361755633207;6805;6903.413209877217;6909.170899492093;6937.965310173417;6988.755393561201;5042;5043.5712964398435;5050.419201791841;5129.512696293846;5140.228965655182;6328.101569529215;6518.902216466851;6569.277379488348;6652.600843949379;6656.267810540933;6373.968130159319;6442.967785161044;6450.9354906450335;6461.741530338733;6476.384743449365;6380.074889141141;6388.968055159695;6389;6449.838754031187;6509.609423434609;6246.718897649525;6308.959021761541;6331.145295385064;6340.302566717565;6396.616203027833;6409.134766806422;6453.354664533509;6511.804645860631;6517.543771935919;6523.6738163092605;6253.1245625613365;6253.968095264412;6320.841978950563;6325.683715814283;6346.873797277964 16:12:39 INFO - PID 22007 | |5;yui.html;956.0487315121455;989.9653512127074;995.3828626251725;1000.5347513406265;1013.292601965688;20308.390748277558;20826.89586552067;20853.478663033413;20879.164833406645;20896;19384.224631014742;19490.415287541397;19532;19861.801381986214;19885.20459181631;1030.2736570717645;1050.9211809114308;1052.2423854824553;1052.9157667386628;1053.189044435784;1029.5624359647156;1030.7783826477305;1042.4943902207424;1042.9791404171913;1043.8329867221246;1106.634810512533;1110.3282514078987;1114.2367478277406;1114.760326529796;1119.9888001119966;1118.3178261260625;1119.306030261235;1120.2830188679252;1120.4621781544822;1121.9943900280527;771.1902502372543;790.5059337913804;795.7612716185179;796.8406318736218;816.9795755106111;20037.1985120595;20261.594768104704;20275.391738247876;20282.188712451483;20287.797122028885;22469.775302246933;22623;23335.53328933429;23466.64800028001;23614.881925590435;17613.383531576463;17777.288908443647;17862.5534361642;18019.369322073795;18079.36722214729;3983.701222408331;4014.3577027675724;4015.19696060789;4035.233305671913;4051.0885050863612;150035.24982375017;151183;151463;153812.9999999989;155287;17105.315787368614;17562.29750809979;17629;17661.7350739739;17798.644027119386;33361.49957750636;33974.49038264428;33979.830100849336;34021.489677654856;34190.658093418744;8984.505852178063;9205.125513076247;9222.077792220723;9253.398529095723;9297.72106836796;4519.163954668397;4562.84030058953;4580.88547786308;4607.262837945913;4621.6764826462495;5902.793402230901;6045.33501314855;6087.360827113178;6095.7866474674065;6119.816405507842;921.7649499377616;924.2282693950626;938.3103418987039;942.0579420579421;948.2745699539857;715.3883429667663;722.3246264742482;730.6967608442543;737.196455863101;752.5672738175571;12406.689832754253;12652;13207.801882971764;13301.334933253298;13541.864581354257;729.8467321862362;732.7765031665393;734.372111844376;742.3689863615883;745.7688116683845;6239.812805615748;6388.936110638834;6430.935690643128;6441.484681225491;6444.484441244783;145370;145871;147697;150609;155373.2231338836;99773;114910.42544787223;115987.99999999831;126618;132678.33660831826;103614;103684.48157759164;104798.47600761948;107554.46222768993;108080;13105.41025653867;14122;14168.858311416754;14209.857901421266;14646.775120573926;49621.503784961686;51082.489175107774;51580.22629660483;51860;52159.73920130375;66715;77951.61024194842;87651;93522;93939.06060939576;20046.298379556647;20694.482637934172;20815.37553873386;20948.162073516887;21135.26026589062;21330.14679412806;21696;21869;22848.885755571115;22977.425564361023;20583.176672932914;20592.897035514725;20820.063097160968;21087.367378978655;21182.682259766425;20269.29057482981;20680.379588612366;20955.371338859248;21044.68432973476;21292.467688307297;18963.620727585094;19177.424677259703;19960.3013894513;19986.70019949673;20149;14790.63023424423;15069.623259418602;15358.155301458528;15371.769423458882;15415.383384664488;14729.263536822902;14935;14957.952943293865;15150.621234469227;15192.46826361072 16:12:39 INFO - PID 22007 | __end_tp_report 16:12:39 INFO - PID 22007 | __start_cc_report 16:12:39 INFO - PID 22007 | _x_x_mozilla_cycle_collect,345 16:12:39 INFO - PID 22007 | __end_cc_report 16:12:39 INFO - PID 22007 | __startTimestamp1504998759881__endTimestamp 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | ------- Summary: start ------- 16:12:39 INFO - PID 22007 | Number of tests: 6 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#0] dojo.html Cycles:165 Average:6341.30 Median:6587.67 stddev:898.63 (13.6%) stddev-sans-first:880.17 16:12:39 INFO - PID 22007 | Values: 3866.9 3869.5 3887.5 3904.7 3910.0 6287.4 6298.3 6343.0 6391.7 6448.2 6398.7 6401.1 6432.9 6531.2 6547.1 5725.2 5734.6 5751.6 5772.1 5807.3 101.8 5683.5 5768.0 5846.8 5912.3 5742.3 5750.9 5804.8 5819.9 5832.7 5734.5 5737.9 5803.9 5811.5 5817.3 5753.2 5755.7 5828.4 5837.3 5840.4 6312.6 6371.4 6476.1 6483.4 6504.8 6801.4 6876.7 6909.1 6922.8 7026.4 6981.6 7045.6 7077.5 7091.9 7094.0 6316.0 6384.0 6450.9 6502.4 6568.6 7036.3 7160.3 7178.2 7206.8 7261.9 6742.7 6773.6 6870.3 6876.9 6912.6 6824.2 6878.1 6966.3 6969.8 7033.3 6801.5 6808.1 6856.3 6883.7 6887.1 6802.3 6862.3 6908.6 6940.0 6942.1 5021.2 5052.1 5108.0 5119.9 5137.4 4584.1 4616.0 4621.2 4632.0 4643.8 6212.9 6323.6 6336.7 6350.6 6353.8 6887.6 6914.2 6930.8 6959.5 6990.3 6289.0 6366.8 6387.7 6453.9 6460.8 5523.3 5551.8 5570.1 5575.3 5649.7 7130.6 7165.7 7175.1 7185.8 7249.9 6799.4 6930.1 6976.6 6978.1 6984.0 7116.3 7124.5 7213.0 7218.3 7228.7 6774.5 6842.6 6853.3 6881.4 6882.1 6938.9 7015.7 7059.3 7065.7 7068.3 6494.8 6558.7 6719.0 6721.1 6816.2 6610.8 6636.8 6646.8 6648.3 6674.1 6573.2 6580.8 6584.9 6597.8 6600.5 6607.7 6663.8 6690.5 6691.7 6694.9 6578.5 6584.6 6587.7 6598.1 6598.3 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#1] ext.html Cycles:180 Average:42897.11 Median:21959.46 stddev:65524.25 (298.4%) stddev-sans-first:65632.37 16:12:39 INFO - PID 22007 | Values: 952.1 963.6 964.2 965.2 965.6 40097.6 44382.3 44400.3 44735.0 44798.0 42535.6 42816.6 42878.0 42902.4 42943.8 7540.7 7652.0 8153.5 8345.3 8349.1 8154.9 8260.3 8267.5 8268.0 8270.3 8265.3 8331.6 8336.4 8337.4 8340.5 8220.8 8268.1 8275.6 8301.0 8305.8 8078.4 8128.3 8129.5 8219.8 8223.7 40234.6 40407.6 40419.6 40426.8 40440.2 3767.1 3804.9 3806.3 3817.8 3821.3 33401.3 33424.5 33498.0 33508.5 33517.3 5496.1 5504.5 5524.5 5593.6 5670.5 205517.0 205749.0 206145.0 206489.0 207697.0 45921.3 46760.0 51302.2 51451.5 51790.7 54195.0 54978.7 55327.7 55398.2 55460.4 13675.9 13790.7 13814.9 13844.7 13852.2 10734.6 10754.7 10762.0 10773.3 10776.4 14951.9 14960.4 15029.2 15044.9 15153.2 5913.9 5963.5 6011.5 6021.1 6023.6 1047.3 1107.2 1126.7 1130.3 1135.9 25789.6 25799.1 25869.0 25958.7 26066.3 1147.9 1196.9 1200.8 1207.3 1221.8 13469.9 13568.5 13763.0 13795.2 13821.3 299388.0 300876.0 301261.0 301262.0 302371.0 55708.4 56240.2 56302.4 56323.0 56479.0 1450.2 1468.2 1493.6 1505.9 1510.0 24961.1 24970.4 25033.0 25034.7 25076.6 40964.6 41174.8 41178.4 41226.2 41259.6 236857.0 237422.0 237802.0 238743.0 239232.0 36756.3 40367.0 40981.4 41092.2 41200.4 48865.0 50465.2 50895.0 50967.0 51031.7 36783.4 37342.8 37543.2 37547.6 37572.4 37182.4 37245.1 37353.0 37634.2 37969.4 42122.8 43118.6 43238.0 43252.6 43299.6 35897.3 36180.8 36301.6 36332.0 36795.0 25943.9 26106.3 27078.5 27158.2 27418.0 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#2] jquery.html Cycles:180 Average:38783.67 Median:23736.41 stddev:97136.03 (409.2%) stddev-sans-first:97366.18 16:12:39 INFO - PID 22007 | Values: 582.1 584.8 596.8 600.8 601.4 23216.8 23926.8 23938.2 23981.8 23987.6 24233.6 25353.7 25963.2 26102.1 26165.7 6475.2 6534.6 6562.8 6563.2 6570.9 6315.4 6513.5 6570.0 6583.9 6622.0 6513.3 6514.7 6535.2 6535.6 6539.7 6492.8 6499.7 6516.9 6522.4 6523.5 6077.1 6114.8 6127.5 6129.9 6133.7 28842.6 29741.0 29963.3 30328.0 30429.5 2222.1 2252.8 2253.2 2253.5 2254.1 20195.7 20221.6 20815.3 21288.1 21305.3 2449.4 2469.5 2512.8 2603.9 2605.3 133605.0 139674.0 151375.0 158123.2 158485.0 14884.9 14937.0 14985.4 15788.9 15874.5 24705.0 24708.4 24766.4 24776.6 24895.8 9719.1 9962.8 10031.9 10095.2 10103.9 8745.8 8760.2 8896.0 8908.7 8955.1 9457.0 9619.3 9755.2 9826.6 9998.8 2720.5 2756.7 2756.9 2796.9 2908.7 1006.6 1052.9 1055.9 1057.2 1076.4 20530.3 21174.7 21330.9 21379.6 21469.8 1111.3 1124.5 1128.2 1129.4 1134.7 11751.9 11893.6 11923.6 11933.0 11933.9 532775.0 554669.0 591281.0 594386.0 617308.0 128041.0 129782.0 130356.3 132034.0 134239.0 1089.3 1177.7 1233.8 1251.9 1260.8 21367.6 21658.0 21677.2 21933.3 21944.2 61262.4 61864.0 62195.0 62786.4 64176.0 79018.2 79057.0 79181.2 79464.6 79862.2 14922.2 15271.5 15283.3 15309.2 15319.8 23566.0 23591.5 23881.3 24015.6 24107.0 19331.2 19646.5 19716.7 19779.6 19794.6 16151.8 16393.1 16415.9 16579.6 17346.3 19469.0 19890.4 19967.7 20161.2 20174.0 15112.5 15157.8 15213.5 15234.4 15240.1 19525.7 19548.0 19617.7 19724.3 19779.1 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#3] mootools.html Cycles:180 Average:10224.21 Median:2577.76 stddev:7660.44 (297.2%) stddev-sans-first:7653.38 16:12:39 INFO - PID 22007 | Values: 1420.8 1461.8 1468.4 1487.4 1488.2 16302.4 17910.2 17920.0 17933.0 17950.8 17365.5 17649.1 17653.8 17683.7 17700.1 2575.3 2616.8 2618.0 2622.5 2629.0 2464.5 2558.2 2561.3 2604.1 2647.8 2502.9 2597.3 2597.4 2597.8 2603.0 2596.0 2605.7 2620.0 2634.5 2636.0 2447.9 2580.3 2612.3 2612.4 2620.3 16463.0 16601.1 16751.2 16792.7 16841.7 7814.8 8080.8 8087.6 8092.4 8092.7 5297.5 5391.9 5480.4 5500.8 5529.6 1942.1 1943.2 1945.4 1980.2 2003.9 29294.7 29480.9 29542.8 29608.6 29612.3 6213.6 6308.3 6440.7 6579.6 6627.6 19459.3 19608.3 19664.5 19673.5 19677.4 7636.1 7813.9 7821.5 7822.7 7822.8 7094.8 7162.3 7162.5 7197.3 7200.0 5242.4 5371.2 5401.0 5427.5 5435.3 1421.1 1423.2 1450.7 1452.1 1455.7 938.8 960.8 974.6 977.8 978.6 8442.7 8559.9 8581.8 9715.0 9734.0 701.6 723.7 731.9 733.7 736.8 5773.4 6003.9 6155.4 6211.7 6303.1 23705.3 23786.6 24545.8 24786.4 24796.8 23256.7 24403.9 24456.9 24530.0 24636.5 12208.0 12213.9 12412.3 12420.8 12487.2 9175.2 9433.9 9438.5 9481.0 9531.0 20836.3 20854.7 20919.2 21112.7 21213.8 21908.0 21957.8 21966.0 22105.6 22127.6 11635.3 11668.1 11719.5 11836.2 11889.6 15252.8 15388.1 15449.2 15458.7 15483.5 11885.1 11911.5 11982.9 11998.8 12147.6 12406.3 12445.4 12564.2 12636.1 12694.9 10054.3 10222.8 10235.5 10289.1 10296.5 8380.6 8432.6 8436.7 8444.9 8554.4 8378.7 8423.8 8540.9 8574.7 8595.6 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#4] prototype.html Cycles:180 Average:5562.53 Median:6198.08 stddev:1556.99 (25.1%) stddev-sans-first:1514.90 16:12:39 INFO - PID 22007 | Values: 533.0 540.4 558.3 561.7 576.5 6192.8 6261.9 6269.8 6280.4 6283.0 6147.1 6183.5 6183.8 6197.6 6201.3 5006.6 5033.5 5035.0 5050.4 5078.8 5010.3 5024.7 5033.7 5038.7 5065.0 4757.6 4986.5 5003.7 5031.3 5071.4 4817.8 4827.3 4838.8 4860.0 4891.7 4381.0 4381.2 4388.7 4390.8 4403.0 6114.9 6121.2 6143.3 6143.7 6149.1 5727.5 5735.7 5740.2 5752.5 5760.2 6568.4 6581.6 6609.7 6610.5 6619.6 4735.3 4876.6 4885.4 4904.8 4909.7 6732.6 6793.2 6833.7 6842.7 6854.6 5122.5 5135.1 5140.9 5144.5 5150.6 5191.3 5193.7 5205.9 5206.1 5210.6 5735.5 5737.7 5757.1 5775.2 5780.1 6603.8 6637.2 6638.1 6647.7 6664.8 1781.4 1790.2 1797.3 1802.6 1812.1 1244.3 1275.5 1286.4 1293.8 1296.8 6196.2 6198.6 6203.3 6245.8 6252.7 6539.3 6634.2 6661.6 6662.1 6702.9 6119.0 6124.4 6124.8 6159.4 6188.0 3451.6 3479.7 3490.5 3517.7 3521.1 6849.9 6898.8 6976.9 6995.9 7023.9 6666.9 6790.6 6868.9 6883.3 6885.3 6775.8 6818.5 6825.9 6933.3 6977.5 6617.0 6678.9 6724.2 6728.9 6775.7 6596.1 6662.5 6691.0 6694.4 6718.4 6805.0 6903.4 6909.2 6938.0 6988.8 5042.0 5043.6 5050.4 5129.5 5140.2 6328.1 6518.9 6569.3 6652.6 6656.3 6374.0 6443.0 6450.9 6461.7 6476.4 6380.1 6389.0 6389.0 6449.8 6509.6 6246.7 6309.0 6331.1 6340.3 6396.6 6409.1 6453.4 6511.8 6517.5 6523.7 6253.1 6254.0 6320.8 6325.7 6346.9 16:12:39 INFO - PID 22007 | 16:12:39 INFO - PID 22007 | [#5] yui.html Cycles:180 Average:28149.01 Median:20636.64 stddev:40465.94 (196.1%) stddev-sans-first:40527.95 16:12:39 INFO - PID 22007 | Values: 956.0 990.0 995.4 1000.5 1013.3 20308.4 20826.9 20853.5 20879.2 20896.0 19384.2 19490.4 19532.0 19861.8 19885.2 1030.3 1050.9 1052.2 1052.9 1053.2 1029.6 1030.8 1042.5 1043.0 1043.8 1106.6 1110.3 1114.2 1114.8 1120.0 1118.3 1119.3 1120.3 1120.5 1122.0 771.2 790.5 795.8 796.8 817.0 20037.2 20261.6 20275.4 20282.2 20287.8 22469.8 22623.0 23335.5 23466.6 23614.9 17613.4 17777.3 17862.6 18019.4 18079.4 3983.7 4014.4 4015.2 4035.2 4051.1 150035.2 151183.0 151463.0 153813.0 155287.0 17105.3 17562.3 17629.0 17661.7 17798.6 33361.5 33974.5 33979.8 34021.5 34190.7 8984.5 9205.1 9222.1 9253.4 9297.7 4519.2 4562.8 4580.9 4607.3 4621.7 5902.8 6045.3 6087.4 6095.8 6119.8 921.8 924.2 938.3 942.1 948.3 715.4 722.3 730.7 737.2 752.6 12406.7 12652.0 13207.8 13301.3 13541.9 729.8 732.8 734.4 742.4 745.8 6239.8 6388.9 6430.9 6441.5 6444.5 145370.0 145871.0 147697.0 150609.0 155373.2 99773.0 114910.4 115988.0 126618.0 132678.3 103614.0 103684.5 104798.5 107554.5 108080.0 13105.4 14122.0 14168.9 14209.9 14646.8 49621.5 51082.5 51580.2 51860.0 52159.7 66715.0 77951.6 87651.0 93522.0 93939.1 20046.3 20694.5 20815.4 20948.2 21135.3 21330.1 21696.0 21869.0 22848.9 22977.4 20583.2 20592.9 20820.1 21087.4 21182.7 20269.3 20680.4 20955.4 21044.7 21292.5 18963.6 19177.4 19960.3 19986.7 20149.0 14790.6 15069.6 15358.2 15371.8 15415.4 14729.3 14935.0 14958.0 15150.6 15192.5 16:12:39 INFO - PID 22007 | -------- Summary: end -------- 16:12:39 INFO - PID 22007 | 16:12:40 INFO - TEST-INFO | 22007: exit 0 16:12:40 INFO - TEST-OK | dromaeo_css | took 1107577ms 16:12:40 INFO - TEST-START | kraken 16:12:40 INFO - Initialising browser for kraken test... 16:12:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47126/getInfo.html -profile /tmp/tmpetta3_/profile 16:12:40 INFO - TEST-INFO | started process 22394 (/builds/slave/test/build/application/firefox/firefox http://localhost:47126/getInfo.html) 16:12:46 INFO - TEST-INFO | 22394: exit 0 16:12:46 INFO - Browser initialized. 16:12:46 INFO - Running cycle 1/1 for kraken test... 16:12:46 INFO - Using env: {'DISPLAY': ':0', 16:12:46 INFO - 'HOME': '/home/cltbld', 16:12:46 INFO - 'JSGC_DISABLE_POISONING': '1', 16:12:46 INFO - 'LANG': 'en_US.UTF-8', 16:12:46 INFO - 'LANGUAGE': 'en_US:en', 16:12:46 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:12:46 INFO - 'LOGNAME': 'cltbld', 16:12:46 INFO - 'MAIL': '/var/mail/cltbld', 16:12:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:46 INFO - 'MOZ_CRASHREPORTER': '1', 16:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:46 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:12:46 INFO - 'MOZ_NO_REMOTE': '1', 16:12:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:46 INFO - 'NO_EM_RESTART': '1', 16:12:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:46 INFO - 'PWD': '/builds/slave/test', 16:12:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:46 INFO - 'RUST_BACKTRACE': 'full', 16:12:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:12:46 INFO - 'SHELL': '/bin/bash', 16:12:46 INFO - 'SHLVL': '1', 16:12:46 INFO - 'TERM': 'linux', 16:12:46 INFO - 'TMOUT': '86400', 16:12:46 INFO - 'USER': 'cltbld', 16:12:46 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582', 16:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:46 INFO - '_': '/tools/buildbot/bin/python'} 16:12:46 INFO - TEST-INFO | started process 22594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpetta3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:47 INFO - PID 22594 | 16:12:47 INFO - PID 22594 | (/builds/slave/test/build/application/firefox/firefox:22646): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:12:47 INFO - PID 22594 | 16:12:57 INFO - PID 22594 | RSS: Main: 163745792 16:12:57 INFO - PID 22594 | 16:13:00 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47126/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:00 INFO - PID 22594 | RSS: Main: 168787968 16:13:00 INFO - PID 22594 | 16:13:03 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47126/tests/kraken/driver.html?testName=audio-dft) 16:13:04 INFO - PID 22594 | RSS: Main: 169361408 16:13:04 INFO - PID 22594 | 16:13:07 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47126/tests/kraken/driver.html?testName=audio-fft) 16:13:07 INFO - PID 22594 | RSS: Main: 164786176 16:13:07 INFO - PID 22594 | 16:13:09 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47126/tests/kraken/driver.html?testName=audio-oscillator) 16:13:10 INFO - PID 22594 | RSS: Main: 166264832 16:13:10 INFO - PID 22594 | 16:13:12 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:13 INFO - PID 22594 | RSS: Main: 166096896 16:13:13 INFO - PID 22594 | 16:13:16 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47126/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:16 INFO - PID 22594 | RSS: Main: 166326272 16:13:16 INFO - PID 22594 | 16:13:20 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47126/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:20 INFO - PID 22594 | RSS: Main: 167006208 16:13:20 INFO - PID 22594 | 16:13:23 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47126/tests/kraken/driver.html?testName=json-parse-financial) 16:13:24 INFO - PID 22594 | RSS: Main: 168914944 16:13:24 INFO - PID 22594 | 16:13:25 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:26 INFO - PID 22594 | RSS: Main: 168652800 16:13:26 INFO - PID 22594 | 16:13:28 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:28 INFO - PID 22594 | RSS: Main: 169058304 16:13:28 INFO - PID 22594 | 16:13:30 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:31 INFO - PID 22594 | RSS: Main: 165941248 16:13:31 INFO - PID 22594 | 16:13:33 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:34 INFO - PID 22594 | RSS: Main: 165904384 16:13:34 INFO - PID 22594 | 16:13:37 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:37 INFO - PID 22594 | RSS: Main: 166723584 16:13:37 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | Cycle 1(1): loaded http://localhost:47126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47126/tests/kraken/driver.html?testName=ai-astar) 16:13:39 INFO - PID 22594 | RSS: Main: 168378368 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | __start_tp_report 16:13:39 INFO - PID 22594 | _x_x_mozilla_page_load 16:13:39 INFO - PID 22594 | _x_x_mozilla_page_load_details 16:13:39 INFO - PID 22594 | |i|pagename|runs| 16:13:39 INFO - PID 22594 | |0;ai-astar;109;105;106;108;107;107;114;106;109;106 16:13:39 INFO - PID 22594 | |1;audio-beat-detection;116;115;118;115;141;112;112;115;112;116 16:13:39 INFO - PID 22594 | |2;audio-dft;163;164;163;161;162;163;166;162;164;165 16:13:39 INFO - PID 22594 | |3;audio-fft;73;72;73;73;73;72;73;73;73;74 16:13:39 INFO - PID 22594 | |4;audio-oscillator;79;79;78;78;77;85;81;82;88;78 16:13:39 INFO - PID 22594 | |5;imaging-gaussian-blur;114;114;114;113;114;113;113;114;117;114 16:13:39 INFO - PID 22594 | |6;imaging-darkroom;151;149;159;148;149;149;148;149;149;150 16:13:39 INFO - PID 22594 | |7;imaging-desaturate;94;96;98;98;98;99;98;98;97;94 16:13:39 INFO - PID 22594 | |8;json-parse-financial;47;43;44;44;46;46;45;43;44;44 16:13:39 INFO - PID 22594 | |9;json-stringify-tinderbox;38;39;39;40;39;39;39;39;39;39 16:13:39 INFO - PID 22594 | |10;stanford-crypto-aes;76;73;72;80;72;73;75;75;72;71 16:13:39 INFO - PID 22594 | |11;stanford-crypto-ccm;110;111;111;111;111;110;109;115;111;124 16:13:39 INFO - PID 22594 | |12;stanford-crypto-pbkdf2;161;166;159;160;153;152;162;166;155;153 16:13:39 INFO - PID 22594 | |13;stanford-crypto-sha256-iterative;60;60;64;58;63;65;58;61;62;58 16:13:39 INFO - PID 22594 | __end_tp_report 16:13:39 INFO - PID 22594 | __start_cc_report 16:13:39 INFO - PID 22594 | _x_x_mozilla_cycle_collect,894 16:13:39 INFO - PID 22594 | __end_cc_report 16:13:39 INFO - PID 22594 | __startTimestamp1504998819863__endTimestamp 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | ------- Summary: start ------- 16:13:39 INFO - PID 22594 | Number of tests: 14 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#0] ai-astar Cycles:10 Average:107.70 Median:107.50 stddev:2.58 (2.4%) stddev-sans-first:2.70 16:13:39 INFO - PID 22594 | Values: 109.0 105.0 106.0 108.0 107.0 107.0 114.0 106.0 109.0 106.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:115.50 stddev:8.60 (7.4%) stddev-sans-first:9.11 16:13:39 INFO - PID 22594 | Values: 116.0 115.0 118.0 115.0 141.0 112.0 112.0 115.0 112.0 116.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 16:13:39 INFO - PID 22594 | Values: 163.0 164.0 163.0 161.0 162.0 163.0 166.0 162.0 164.0 165.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 16:13:39 INFO - PID 22594 | Values: 73.0 72.0 73.0 73.0 73.0 72.0 73.0 73.0 73.0 74.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:80.00 stddev:3.57 (4.5%) stddev-sans-first:3.74 16:13:39 INFO - PID 22594 | Values: 79.0 79.0 78.0 78.0 77.0 85.0 81.0 82.0 88.0 78.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 16:13:39 INFO - PID 22594 | Values: 114.0 114.0 114.0 113.0 114.0 113.0 113.0 114.0 117.0 114.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.00 stddev:3.25 (2.2%) stddev-sans-first:3.43 16:13:39 INFO - PID 22594 | Values: 151.0 149.0 159.0 148.0 149.0 149.0 148.0 149.0 149.0 150.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:98.00 stddev:1.76 (1.8%) stddev-sans-first:1.50 16:13:39 INFO - PID 22594 | Values: 94.0 96.0 98.0 98.0 98.0 99.0 98.0 98.0 97.0 94.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:44.50 stddev:1.35 (3.0%) stddev-sans-first:1.12 16:13:39 INFO - PID 22594 | Values: 47.0 43.0 44.0 44.0 46.0 46.0 45.0 43.0 44.0 44.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:0.47 (1.2%) stddev-sans-first:0.33 16:13:39 INFO - PID 22594 | Values: 38.0 39.0 39.0 40.0 39.0 39.0 39.0 39.0 39.0 39.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:2.69 (3.6%) stddev-sans-first:2.74 16:13:39 INFO - PID 22594 | Values: 76.0 73.0 72.0 80.0 72.0 73.0 75.0 75.0 72.0 71.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:111.00 stddev:4.40 (4.0%) stddev-sans-first:4.59 16:13:39 INFO - PID 22594 | Values: 110.0 111.0 111.0 111.0 111.0 110.0 109.0 115.0 111.0 124.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:160.50 stddev:5.25 (3.3%) stddev-sans-first:5.50 16:13:39 INFO - PID 22594 | Values: 161.0 166.0 159.0 160.0 153.0 152.0 162.0 166.0 155.0 153.0 16:13:39 INFO - PID 22594 | 16:13:39 INFO - PID 22594 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.50 stddev:2.56 (4.2%) stddev-sans-first:2.69 16:13:39 INFO - PID 22594 | Values: 60.0 60.0 64.0 58.0 63.0 65.0 58.0 61.0 62.0 58.0 16:13:39 INFO - PID 22594 | -------- Summary: end -------- 16:13:39 INFO - PID 22594 | 16:13:40 INFO - PID 22594 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:13:40 INFO - TEST-INFO | 22594: exit 0 16:13:40 INFO - TEST-OK | kraken | took 59974ms 16:13:40 INFO - SUITE-END | took 1167s 16:13:41 INFO - Completed test suite (00:19:28) 16:13:41 INFO - javascript benchmark 16:13:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9004.596025512808, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3866.903327416814, 3869.516310461192, 3887.4557561941333, 3904.687624990001, 3910.022494376404, 6287.434130928215, 6298.307186209513, 6343.0, 6391.744330226797, 6448.193975753031, 6398.680065996693, 6401.071844582544, 6432.871342573146, 6531.216254049521, 6547.050677651738, 5725.227094342252, 5734.598578099514, 5751.597388182829, 5772.105323674838, 5807.303123625171, 101.7852924302251, 5683.54531637468, 5767.971160144193, 5846.795362162326, 5912.349641539448, 5742.339630942453, 5750.856228594277, 5804.767809287623, 5819.854503637401, 5832.708364581754, 5734.541236701054, 5737.88524229513, 5803.912941305884, 5811.535077193815, 5817.331006934172, 5753.194552762617, 5755.740991655385, 5828.446297601721, 5837.328707198684, 5840.415958404168, 6312.589681670676, 6371.362863713638, 6476.093346931433, 6483.384078512534, 6504.837379065514, 6801.35387138226, 6876.724931002754, 6909.1018167638385, 6922.757703480354, 7026.43788496919, 6981.616011119387, 7045.612491312976, 7077.504574679774, 7091.929080709178, 7094.042304288907, 6315.96842015787, 6383.96808015957, 6450.870982580369, 6502.414782669535, 6568.6058836469965, 7036.261192574808, 7160.319769621878, 7178.174509931425, 7206.783796486114, 7261.927380726125, 6742.662866856637, 6773.593584384953, 6870.3473170048765, 6876.931230687729, 6912.585244885323, 6824.21521525021, 6878.140232470942, 6966.338197871194, 6969.7909062728195, 7033.331833475811, 6801.5238933274195, 6808.148981377328, 6856.314368563104, 6883.65581720912, 6887.104676392037, 6802.285759995229, 6862.279460656559, 6908.5509441886115, 6940.0, 6942.062821519131, 5021.171506701354, 5052.090623687698, 5108.029474399852, 5119.948800512022, 5137.357830271216, 4584.129015487047, 4615.95384046162, 4621.237495813153, 4632.0, 4643.8374656886845, 6212.937870621236, 6323.588966717149, 6336.6831658416895, 6350.6189628621505, 6353.809385718436, 6887.621180835102, 6914.1702995639835, 6930.792076237721, 6959.512834101564, 6990.335918087875, 6289.0, 6366.840828979312, 6387.712552935036, 6453.870922581522, 6460.838479037968, 5523.337199536001, 5551.750171242304, 5570.080936645408, 5575.303087114111, 5649.68926709035, 7130.607816570138, 7165.713371465083, 7175.138983322035, 7185.784426467214, 7249.8550028999125, 6799.354061364163, 6930.064441300461, 6976.5814051157095, 6978.057962175041, 6983.9650801745665, 7116.252793456612, 7124.536905101152, 7212.954121652436, 7218.27817218274, 7228.674709637974, 6774.525783195129, 6842.623655698984, 6853.314668533107, 6881.41507971828, 6882.139732533434, 6938.895916561357, 7015.6842942066705, 7059.329363710439, 7065.6820443081215, 7068.257832927468, 6494.837629059311, 6558.704858281484, 6719.0, 6721.092652491851, 6816.182058153054, 6610.8347291318105, 6636.83407914806, 6646.83382915431, 6648.335166483506, 6674.132362792806, 6573.211214654272, 6580.80257592273, 6584.868302633825, 6597.835054123685, 6600.504962127956, 6607.7356905725155, 6663.766768163091, 6690.531662783558, 6691.732330706912, 6694.866102678016, 6578.506612004215, 6584.604923704593, 6587.670616469061, 6598.076269322395, 6598.307177746459], "value": 6282.589144677592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.11453348386, 963.580842333585, 964.17562983649, 965.2229954886318, 965.5510187762688, 40097.59902400979, 44382.33426498605, 44400.3339949901, 44735.0, 44798.0, 42535.574644253546, 42816.57183428165, 42878.0, 42902.35646465298, 42943.78528107355, 7540.698372065124, 7651.961740191291, 8153.510789352628, 8345.290650294732, 8349.123342049059, 8154.918450815505, 8260.29787468066, 8267.545285009322, 8268.049174344967, 8270.297024752874, 8265.338772898154, 8331.583420828965, 8336.416450848443, 8337.416380853343, 8340.457870238415, 8220.753377398627, 8268.131846156157, 8275.586220689001, 8300.958495207515, 8305.792355191139, 8078.434509584332, 8128.268455839003, 8129.512229266263, 8219.794505137359, 8223.671053157866, 40234.59765402367, 40407.595924040674, 40419.59580404188, 40426.79786601078, 40440.19119617621, 3767.1335592813534, 3804.8668296609485, 3806.3148633246005, 3817.8472861085525, 3821.312163810513, 33401.3319733604, 33424.49863252053, 33498.0, 33508.49737253943, 33517.32965340679, 5496.065668836308, 5504.504594586467, 5524.530414914737, 5593.636413633101, 5670.489655930986, 205517.0, 205749.0, 206145.0, 206489.0, 207697.0, 45921.31118033232, 46760.0, 51302.230466543035, 51451.48548514467, 51790.741046294526, 54195.0, 54978.725106375015, 55327.72336138294, 55398.16902746462, 55460.445395545525, 13675.931620341835, 13790.65523361924, 13814.930925345308, 13844.653883652989, 13852.238126902916, 10734.624288149877, 10754.73113172177, 10762.031417172491, 10773.299735517166, 10776.407297598551, 14951.850481495047, 14960.401583936738, 15029.248537573078, 15044.924775376054, 15153.166575838215, 5913.852153696192, 5963.522918166536, 6011.48902343297, 6021.0968354746265, 6023.578349515579, 1047.3244757131608, 1107.1530279336314, 1126.6563698072166, 1130.2596799096605, 1135.9488823002985, 25789.61315580268, 25799.097031603804, 25869.0, 25958.74041259601, 26066.34834129162, 1147.8909503597145, 1196.8503937007874, 1200.771853347861, 1207.2756346192214, 1221.7922953097996, 13469.865301347058, 13568.525101621395, 13763.036587438783, 13795.2412617305, 13821.308934553232, 299388.0, 300876.0, 301261.0, 301262.0, 302371.0, 55708.44291557113, 56240.15639765407, 56302.43697563054, 56323.0, 56479.0, 1450.1806479339139, 1468.155810409019, 1493.6191271225769, 1505.902116362433, 1509.9924500377429, 24961.137241768785, 24970.37574060663, 25032.998680052595, 25034.74965250324, 25076.62385064262, 40964.59035409727, 41174.79412602918, 41178.38232426456, 41226.175476490906, 41259.587404126774, 236857.0, 237422.0, 237802.0, 238743.0, 239232.0, 36756.264874702894, 40367.0, 40981.38527922024, 41092.17815643611, 41200.38199426951, 48865.0, 50465.24302135544, 50894.982100358524, 50967.0, 51031.74484127704, 36783.44824827576, 37342.8132859334, 37543.24913501769, 37547.62452375441, 37572.436413454365, 37182.44226336661, 37245.0688732773, 37353.0, 37634.24731505409, 37969.4304585437, 42122.78938605287, 43118.56881431145, 43238.0, 43252.56747432611, 43299.56700433081, 35897.28205435824, 36180.81909590435, 36301.636983629825, 36332.0, 36795.0, 25943.870280648476, 26106.347341316618, 27078.458430831666, 27158.1852544424, 27418.0], "value": 18586.385052265974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1093726598303, 584.8011676030148, 596.8275477262762, 600.8077415227126, 601.4376557918346, 23216.76783232167, 23926.76073239267, 23938.16216432425, 23981.76018239817, 23987.640185397235, 24233.63649545258, 25353.746462535368, 25963.221103366883, 26102.08642697506, 26165.73834261657, 6475.222973243206, 6534.640594767286, 6562.770303039395, 6563.245226798907, 6570.93429065708, 6315.3684631536935, 6513.544051916368, 6570.047343135243, 6583.868322633544, 6622.0, 6513.316101809313, 6514.739410423577, 6535.215774107114, 6535.575187612813, 6539.6730163491875, 6492.805215843532, 6499.675016249193, 6516.869662606721, 6522.412982831521, 6523.510736694767, 6077.118817771398, 6114.847128821771, 6127.4791642710425, 6129.877402451926, 6133.693315334215, 28842.567361489593, 29741.0, 29963.25091872699, 30328.0, 30429.543556846664, 2222.0889435331596, 2252.76345983671, 2253.2001139595372, 2253.4816992091746, 2254.1434254983, 20195.697064544045, 20221.595568088702, 20815.271465498634, 21288.148474061018, 21305.25431609886, 2449.448874003353, 2469.4814089041324, 2512.7612876776675, 2603.908863189798, 2605.2965699261094, 133605.0, 139674.0, 151375.0, 158123.2093839535, 158485.0, 14884.883633727297, 14937.0, 14985.400583976736, 15788.921055394649, 15874.52376428709, 24705.0, 24708.38229044288, 24766.38084047877, 24776.628350574756, 24895.751042489705, 9719.125278724949, 9962.800743985079, 10031.949840250898, 10095.242856785624, 10103.949480252699, 8745.825083498421, 8760.211580957744, 8895.955520222358, 8908.688195913111, 8955.059718729439, 9456.959734429207, 9619.344649033323, 9755.219582433388, 9826.557804898797, 9998.80002399948, 2720.469508445834, 2756.6554180727408, 2756.9310767230577, 2796.9300767480568, 2908.6800451950267, 1006.5671761142779, 1052.9157667386592, 1055.8732952045805, 1057.1806849691397, 1076.4402510694395, 20530.281440149523, 21174.682379764316, 21330.893345533485, 21379.572408551743, 21469.78530214709, 1111.288775183883, 1124.4995976790249, 1128.2440764687678, 1129.3901293301526, 1134.7390100276982, 11751.882481175078, 11893.608733432471, 11923.582674606347, 11933.019507719222, 11933.864836009112, 532775.0, 554669.0, 591281.0, 594386.0, 617308.0, 128041.0, 129782.0, 130356.3482182583, 132034.0, 134239.0, 1089.2974031749477, 1177.670252329349, 1233.8272641830151, 1251.8810712982252, 1260.7730608490376, 21367.593947780144, 21658.0, 21677.241296555178, 21933.341999740034, 21944.231951881608, 61262.38737612745, 61864.0, 62195.0, 62786.37213627988, 64176.0, 79018.20981790338, 79057.0, 79181.20818791738, 79464.60267698625, 79862.20137798548, 14922.179280139262, 15271.472852715084, 15283.312250948957, 15309.234538273264, 15319.770203446735, 23566.0, 23591.528169436857, 23881.283561493183, 24015.639765403183, 24107.0, 19331.226750929804, 19646.508837279183, 19716.704249436556, 19779.604407911473, 19794.60410791805, 16151.838481615034, 16393.09837958924, 16415.931409201647, 16579.585510361856, 17346.306147754454, 19469.0, 19890.403287901387, 19967.700484492452, 20161.193552257744, 20174.0, 15112.546623601309, 15157.848421515644, 15213.543593692208, 15234.3906243749, 15240.085594864344, 19525.70711439358, 19548.022598870284, 19617.70573441371, 19724.30964916221, 19779.109940052444], "value": 12582.59760601829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.8437071922087, 1461.7661174212128, 1468.3686015013548, 1487.353001444371, 1488.2335597167453, 16302.429414970478, 17910.194041268143, 17920.0, 17933.0, 17950.82049179508, 17365.47903562892, 17649.117544122775, 17653.82346176541, 17683.73474397885, 17700.114994250267, 2575.25317657879, 2616.82990605611, 2617.986910065447, 2622.4755048990182, 2629.0404002539126, 2464.544059349017, 2558.168595206556, 2561.346856551577, 2604.127617248224, 2647.801414893881, 2502.949941001179, 2597.324695579144, 2597.428565715549, 2597.7791887689473, 2603.0368763557512, 2595.9610605840926, 2605.7003444603924, 2619.9607005894927, 2634.459935713174, 2635.9736402636017, 2447.902083916641, 2580.2646245820038, 2612.2685648018587, 2612.386089269039, 2620.253227830059, 16463.0, 16601.086940218283, 16751.16244187798, 16792.66414671712, 16841.747373789403, 7814.804629884242, 8080.797980050545, 8087.636056377477, 8092.433529652927, 8092.676292948275, 5297.549708274802, 5391.946080539184, 5480.424555421663, 5500.779968801283, 5529.557635389159, 1942.0969249299144, 1943.1838627776367, 1945.3677554794606, 1980.2178139634764, 2003.9398818035336, 29294.70705292941, 29480.852595736884, 29542.784291178246, 29608.55587166194, 29612.259693507618, 6213.565050446426, 6308.3060863305, 6440.67796610177, 6579.605223686594, 6627.602343859384, 19459.34595559365, 19608.313709020116, 19664.508387290432, 19673.508162296057, 19677.409677709693, 7636.08366995964, 7813.921860781433, 7821.491603045783, 7822.726204582812, 7822.8435431291055, 7094.787156385317, 7162.283771622796, 7162.46281528877, 7197.316254955876, 7199.964000179965, 5242.423333433319, 5371.194320851825, 5400.972995134999, 5427.48438898304, 5435.320584926884, 1421.0763004047246, 1423.181670539444, 1450.724362371146, 1452.0924422236103, 1455.660792071297, 938.7981583959481, 960.7550074730899, 974.6491263145263, 977.8484334928097, 978.5596481583316, 8442.746717598482, 8559.914400856036, 8581.828363432696, 9714.951425242829, 9734.026597340351, 701.5755467941924, 723.6888138100667, 731.8902164675342, 733.6991833348302, 736.8010637127945, 5773.364929857712, 6003.919294527027, 6155.384461553809, 6211.65835879031, 6303.086052522359, 23705.288841334786, 23786.64320035201, 24545.754542454702, 24786.380340491272, 24796.752032479806, 23256.65115023276, 24403.877980609985, 24456.877715611306, 24530.0, 24636.50726985486, 12207.999999999822, 12213.877861221274, 12412.317322547347, 12420.75158496825, 12487.188332758524, 9175.22010629104, 9433.905660943303, 9438.528073596155, 9481.0, 9530.95234523823, 20836.270730524964, 20854.687179692013, 20919.163233470492, 21112.68330975006, 21213.787862121182, 21908.0, 21957.780422195574, 21966.0, 22105.557888842453, 22127.55744885061, 11635.301881887113, 11668.066554675775, 11719.472623731783, 11836.171467997157, 11889.583864564698, 15252.77120843166, 15388.076715397112, 15449.150296733787, 15458.690826183638, 15483.5354939352, 11885.108616853599, 11911.523539058688, 11982.940085299517, 11998.820017699567, 12147.635570932885, 12406.25562466255, 12445.439955202219, 12564.246145231315, 12636.115471916877, 12694.936525317315, 10054.34646747959, 10222.846657299997, 10235.48822558884, 10289.125424339016, 10296.485175741032, 8380.580970951307, 8432.620532075949, 8436.746897593082, 8444.873326900224, 8554.401191916506, 8378.664853405795, 8423.789405264672, 8540.871886921577, 8574.699885503978, 8595.570221488775], "value": 7022.756087608286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.989340213196, 540.3677697094399, 558.3467343208446, 561.7415988645223, 576.4754073792849, 6192.845178870531, 6261.937380626198, 6269.771067900029, 6280.434760871521, 6283.0, 6147.139400483936, 6183.536234782398, 6183.81448556544, 6197.597156184845, 6201.255849298091, 5006.599472042246, 5033.521815427538, 5034.974825125888, 5050.368703912011, 5078.7968481260705, 5010.273510340999, 5024.673396229252, 5033.723145227029, 5038.748062596874, 5064.974675126619, 4757.64317676174, 4986.476419975905, 5003.674761140533, 5031.3207716958295, 5071.366079240095, 4817.759112044401, 4827.324174615556, 4838.758062096881, 4860.0, 4891.706497610119, 4380.956190438087, 4381.233284175257, 4388.736675799462, 4390.846320378803, 4402.977985110086, 6114.92988726971, 6121.204243448323, 6143.296949342275, 6143.723532441051, 6149.077638354238, 5727.510847179721, 5735.684537350444, 5740.225069615591, 5752.5110365618975, 5760.222369980041, 6568.408843204134, 6581.605103693793, 6609.735610575572, 6610.504212184105, 6619.602823830537, 4735.313379559944, 4876.561109500127, 4885.364902562644, 4904.779284932187, 4909.68087074339, 6732.629705366203, 6793.150856142982, 6833.6674348502065, 6842.692078856414, 6854.6229957352325, 5122.462141475166, 5135.075686376414, 5140.948590514122, 5144.536991670693, 5150.613703972217, 5191.273221748958, 5193.740312984336, 5205.947940520622, 5206.140986737221, 5210.583153347723, 5735.4551317624755, 5737.684427356536, 5757.107648314518, 5775.180818042303, 5780.132980053026, 6603.8113139635325, 6637.1703537057865, 6638.137042184485, 6647.734090636417, 6664.766733164316, 1781.403229917966, 1790.185465613143, 1797.3170195325954, 1802.6484835457222, 1812.139233863904, 1244.3404995352478, 1275.4961790093048, 1286.4403984266874, 1293.8484748573776, 1296.7925131978839, 6196.225471816023, 6198.566100372931, 6203.348648391944, 6245.750169993149, 6252.718627661766, 6539.313372095861, 6634.170728658918, 6661.566998145202, 6662.133922590129, 6702.932970670231, 6119.0, 6124.38756124384, 6124.816255512342, 6159.384061593805, 6187.969060154671, 3451.6030656474327, 3479.6868281854754, 3490.5462289902152, 3517.66582174693, 3521.1373213562842, 6849.931500685029, 6898.827529311808, 6976.918577620477, 6995.930040699528, 7023.89464158038, 6666.899996500057, 6790.620050067679, 6868.896966545506, 6883.346082122191, 6885.345892140239, 6775.762848300285, 6818.454523638097, 6825.863482730417, 6933.306669333027, 6977.511574189758, 6616.966915165393, 6678.866422671422, 6724.226713927961, 6728.92337226061, 6775.728970841308, 6596.142501474777, 6662.533622646368, 6691.0, 6694.430973367318, 6718.361755633207, 6805.0, 6903.413209877217, 6909.170899492093, 6937.965310173417, 6988.755393561201, 5042.0, 5043.5712964398435, 5050.419201791841, 5129.512696293846, 5140.228965655182, 6328.101569529215, 6518.902216466851, 6569.277379488348, 6652.600843949379, 6656.267810540933, 6373.968130159319, 6442.967785161044, 6450.9354906450335, 6461.741530338733, 6476.384743449365, 6380.074889141141, 6388.968055159695, 6389.0, 6449.838754031187, 6509.609423434609, 6246.718897649525, 6308.959021761541, 6331.145295385064, 6340.302566717565, 6396.616203027833, 6409.134766806422, 6453.354664533509, 6511.804645860631, 6517.543771935919, 6523.6738163092605, 6253.1245625613365, 6253.968095264412, 6320.841978950563, 6325.683715814283, 6346.873797277964], "value": 5114.956560014895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.0487315121455, 989.9653512127074, 995.3828626251725, 1000.5347513406265, 1013.292601965688, 20308.390748277558, 20826.89586552067, 20853.478663033413, 20879.164833406645, 20896.0, 19384.224631014742, 19490.415287541397, 19532.0, 19861.801381986214, 19885.20459181631, 1030.2736570717645, 1050.9211809114308, 1052.2423854824553, 1052.9157667386628, 1053.189044435784, 1029.5624359647156, 1030.7783826477305, 1042.4943902207424, 1042.9791404171913, 1043.8329867221246, 1106.634810512533, 1110.3282514078987, 1114.2367478277406, 1114.760326529796, 1119.9888001119966, 1118.3178261260625, 1119.306030261235, 1120.2830188679252, 1120.4621781544822, 1121.9943900280527, 771.1902502372543, 790.5059337913804, 795.7612716185179, 796.8406318736218, 816.9795755106111, 20037.1985120595, 20261.594768104704, 20275.391738247876, 20282.188712451483, 20287.797122028885, 22469.775302246933, 22623.0, 23335.53328933429, 23466.64800028001, 23614.881925590435, 17613.383531576463, 17777.288908443647, 17862.5534361642, 18019.369322073795, 18079.36722214729, 3983.701222408331, 4014.3577027675724, 4015.19696060789, 4035.233305671913, 4051.0885050863612, 150035.24982375017, 151183.0, 151463.0, 153812.9999999989, 155287.0, 17105.315787368614, 17562.29750809979, 17629.0, 17661.7350739739, 17798.644027119386, 33361.49957750636, 33974.49038264428, 33979.830100849336, 34021.489677654856, 34190.658093418744, 8984.505852178063, 9205.125513076247, 9222.077792220723, 9253.398529095723, 9297.72106836796, 4519.163954668397, 4562.84030058953, 4580.88547786308, 4607.262837945913, 4621.6764826462495, 5902.793402230901, 6045.33501314855, 6087.360827113178, 6095.7866474674065, 6119.816405507842, 921.7649499377616, 924.2282693950626, 938.3103418987039, 942.0579420579421, 948.2745699539857, 715.3883429667663, 722.3246264742482, 730.6967608442543, 737.196455863101, 752.5672738175571, 12406.689832754253, 12652.0, 13207.801882971764, 13301.334933253298, 13541.864581354257, 729.8467321862362, 732.7765031665393, 734.372111844376, 742.3689863615883, 745.7688116683845, 6239.812805615748, 6388.936110638834, 6430.935690643128, 6441.484681225491, 6444.484441244783, 145370.0, 145871.0, 147697.0, 150609.0, 155373.2231338836, 99773.0, 114910.42544787223, 115987.99999999831, 126618.0, 132678.33660831826, 103614.0, 103684.48157759164, 104798.47600761948, 107554.46222768993, 108080.0, 13105.41025653867, 14122.0, 14168.858311416754, 14209.857901421266, 14646.775120573926, 49621.503784961686, 51082.489175107774, 51580.22629660483, 51860.0, 52159.73920130375, 66715.0, 77951.61024194842, 87651.0, 93522.0, 93939.06060939576, 20046.298379556647, 20694.482637934172, 20815.37553873386, 20948.162073516887, 21135.26026589062, 21330.14679412806, 21696.0, 21869.0, 22848.885755571115, 22977.425564361023, 20583.176672932914, 20592.897035514725, 20820.063097160968, 21087.367378978655, 21182.682259766425, 20269.29057482981, 20680.379588612366, 20955.371338859248, 21044.68432973476, 21292.467688307297, 18963.620727585094, 19177.424677259703, 19960.3013894513, 19986.70019949673, 20149.0, 14790.63023424423, 15069.623259418602, 15358.155301458528, 15371.769423458882, 15415.383384664488, 14729.263536822902, 14935.0, 14957.952943293865, 15150.621234469227, 15192.46826361072], "value": 10099.609940685556, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1392.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 106.0, 108.0, 107.0, 107.0, 114.0, 106.0, 109.0, 106.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 118.0, 115.0, 141.0, 112.0, 112.0, 115.0, 112.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 161.0, 162.0, 163.0, 166.0, 162.0, 164.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 77.0, 85.0, 81.0, 82.0, 88.0, 78.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 117.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 159.0, 148.0, 149.0, 149.0, 148.0, 149.0, 149.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 98.0, 98.0, 98.0, 99.0, 98.0, 98.0, 97.0, 94.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 43.0, 44.0, 44.0, 46.0, 46.0, 45.0, 43.0, 44.0, 44.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 40.0, 39.0, 39.0, 39.0, 39.0, 39.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 72.0, 80.0, 72.0, 73.0, 75.0, 75.0, 72.0, 71.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 109.0, 115.0, 111.0, 124.0], "value": 112.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 159.0, 160.0, 153.0, 152.0, 162.0, 166.0, 155.0, 153.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 64.0, 58.0, 63.0, 65.0, 58.0, 61.0, 62.0, 58.0], "value": 60.9, "unit": "score"}]}]} 16:13:41 INFO - Return code: 0 16:13:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:41 INFO - # TBPL SUCCESS # 16:13:41 INFO - Running post-action listener: _package_coverage_data 16:13:41 INFO - Running post-action listener: _resource_record_post_action 16:13:41 INFO - [mozharness: 2017-09-09 23:13:41.152960Z] Finished run-tests step (success) 16:13:41 INFO - Running post-run listener: _resource_record_post_run 16:13:41 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286699520; Read time: 4; Write time: 201392 16:13:41 INFO - TinderboxPrint: CPU usage
13.0% 16:13:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 16:13:41 INFO - TinderboxPrint: I/O write bytes / time
286,699,520 / 201,392 16:13:41 INFO - TinderboxPrint: CPU idle
8,213.2 (86.9%) 16:13:41 INFO - TinderboxPrint: CPU user
1,185.2 (12.5%) 16:13:41 INFO - TinderboxPrint: Swap in / out
0 / 0 16:13:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12488704; Read time: 0; Write time: 1224 16:13:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:13:41 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274210816; Read time: 4; Write time: 200168 16:13:41 INFO - Running post-run listener: _upload_blobber_files 16:13:41 INFO - Blob upload gear active. 16:13:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:43 INFO - (blobuploader) - INFO - Done attempting. 16:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:46 INFO - (blobuploader) - INFO - Done attempting. 16:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:13:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:47 INFO - (blobuploader) - INFO - Done attempting. 16:13:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:13:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:48 INFO - (blobuploader) - INFO - Done attempting. 16:13:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:48 INFO - Return code: 0 16:13:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d83275466dd80bec9a600d65f8b9d196f3ab268516d6db9dfd5c53f3cf1ce2969174a14ea5cf0839483f402fe262b94a04349ff5f65a673fdc9dc5f881f908c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fed2118d6e7ae4a9e5cdeaaa829b238aad2147cbf29555fe0fcd70c79876dae3e4d06a224351565181b45e872ee8cd4f5f383c22288e36346d1d213ad0db072", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c98aac806fd18845ecc5db5d5dc5cd2a598fbb8fcf1f66514b222dfabc8f2e75f99fe6ad5d1bbfe030f6c97d865a957bd6472f15dc3e8112bb694ed9e9191cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee2dd13beca0d31df0224dac2fe31be01b18deaa60b5b19a7ce7da09aec6c28bf0434f94ba07f7e469b771b817dc122c887f09bfaa22887558963a1c648a0ee"} 16:13:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:48 INFO - Contents: 16:13:48 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d83275466dd80bec9a600d65f8b9d196f3ab268516d6db9dfd5c53f3cf1ce2969174a14ea5cf0839483f402fe262b94a04349ff5f65a673fdc9dc5f881f908c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fed2118d6e7ae4a9e5cdeaaa829b238aad2147cbf29555fe0fcd70c79876dae3e4d06a224351565181b45e872ee8cd4f5f383c22288e36346d1d213ad0db072", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c98aac806fd18845ecc5db5d5dc5cd2a598fbb8fcf1f66514b222dfabc8f2e75f99fe6ad5d1bbfe030f6c97d865a957bd6472f15dc3e8112bb694ed9e9191cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee2dd13beca0d31df0224dac2fe31be01b18deaa60b5b19a7ce7da09aec6c28bf0434f94ba07f7e469b771b817dc122c887f09bfaa22887558963a1c648a0ee"} 16:13:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:48 INFO - Copying logs to upload dir... 16:13:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.076621 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-09-09 16:13:48.720519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 16:13:48.726632) ========= 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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 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/7d83275466dd80bec9a600d65f8b9d196f3ab268516d6db9dfd5c53f3cf1ce2969174a14ea5cf0839483f402fe262b94a04349ff5f65a673fdc9dc5f881f908c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fed2118d6e7ae4a9e5cdeaaa829b238aad2147cbf29555fe0fcd70c79876dae3e4d06a224351565181b45e872ee8cd4f5f383c22288e36346d1d213ad0db072", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c98aac806fd18845ecc5db5d5dc5cd2a598fbb8fcf1f66514b222dfabc8f2e75f99fe6ad5d1bbfe030f6c97d865a957bd6472f15dc3e8112bb694ed9e9191cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee2dd13beca0d31df0224dac2fe31be01b18deaa60b5b19a7ce7da09aec6c28bf0434f94ba07f7e469b771b817dc122c887f09bfaa22887558963a1c648a0ee"} build_url:https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/NDWkOfmBRomD9ih9HcxR6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d83275466dd80bec9a600d65f8b9d196f3ab268516d6db9dfd5c53f3cf1ce2969174a14ea5cf0839483f402fe262b94a04349ff5f65a673fdc9dc5f881f908c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fed2118d6e7ae4a9e5cdeaaa829b238aad2147cbf29555fe0fcd70c79876dae3e4d06a224351565181b45e872ee8cd4f5f383c22288e36346d1d213ad0db072", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c98aac806fd18845ecc5db5d5dc5cd2a598fbb8fcf1f66514b222dfabc8f2e75f99fe6ad5d1bbfe030f6c97d865a957bd6472f15dc3e8112bb694ed9e9191cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fee2dd13beca0d31df0224dac2fe31be01b18deaa60b5b19a7ce7da09aec6c28bf0434f94ba07f7e469b771b817dc122c887f09bfaa22887558963a1c648a0ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 16:13:48.757472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 16:13:48.757874) ========= 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=930c87414c89fc706ee2024c000001c6-1504997594.3045-1597326582 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 16:13:48.813143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 16:13:48.813596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 16:13:48.814001) ========= ========= Total master_lag: 0.19 =========