builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1505211924.63 results: success (0) revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.625538) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.625986) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.626261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.688063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.688377) ========= 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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 03:25:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.9M=0s 2017-09-12 03:25:24 (38.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150636 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.901174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.901477) ========= 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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018713 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.963076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.963410) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 175f1366daee80cde53386a4627402ed3af4c038 --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 175f1366daee80cde53386a4627402ed3af4c038 --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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 03:25:24,941 truncating revision to first 12 chars 2017-09-12 03:25:24,941 Setting DEBUG logging. 2017-09-12 03:25:24,941 attempt 1/10 2017-09-12 03:25:24,941 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/175f1366daee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 03:25:25,181 unpacking tar archive at: mozilla-central-175f1366daee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.553418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.556723) ========= script_repo_revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.557075) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.557330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.573154) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-09-12 03:25:25.573435) ========= /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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:25 INFO - MultiFileLogger online at 20170912 03:25:25 in /builds/slave/test 03:25:25 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 03:25:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:25 INFO - {'append_to_log': False, 03:25:25 INFO - 'base_work_dir': '/builds/slave/test', 03:25:25 INFO - 'blob_upload_branch': 'Firefox', 03:25:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:25 INFO - 'branch': 'Firefox', 03:25:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:25 INFO - 'code_coverage': False, 03:25:25 INFO - 'config_files': ('talos/linux_config.py',), 03:25:25 INFO - 'default_actions': ('clobber', 03:25:25 INFO - 'read-buildbot-config', 03:25:25 INFO - 'download-and-extract', 03:25:25 INFO - 'populate-webroot', 03:25:25 INFO - 'create-virtualenv', 03:25:25 INFO - 'install', 03:25:25 INFO - 'setup-mitmproxy', 03:25:25 INFO - 'run-tests'), 03:25:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:25 INFO - 'disable_ccov_upload': False, 03:25:25 INFO - 'disable_stylo': False, 03:25:25 INFO - 'download_minidump_stackwalk': True, 03:25:25 INFO - 'download_symbols': 'ondemand', 03:25:25 INFO - 'enable_stylo': False, 03:25:25 INFO - 'enable_webrender': False, 03:25:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:25:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:25 INFO - 'gecko_profile': False, 03:25:25 INFO - 'gecko_profile_interval': 0, 03:25:25 INFO - 'installer_path': 'installer.exe', 03:25:25 INFO - 'log_level': 'info', 03:25:25 INFO - 'log_name': 'talos', 03:25:25 INFO - 'log_to_console': True, 03:25:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:25 INFO - 'opt_config_files': (), 03:25:25 INFO - 'pip_index': False, 03:25:25 INFO - 'suite': 'dromaeojs-e10s', 03:25:25 INFO - 'system_bits': '32', 03:25:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:25 INFO - 'title': 'talos-linux64-ix-038', 03:25:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:25 INFO - 'use_talos_json': True, 03:25:25 INFO - 'verify': 'False', 03:25:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:25 INFO - 'work_dir': 'build'} 03:25:25 INFO - [mozharness: 2017-09-12 10:25:25.765109Z] Running clobber step. 03:25:25 INFO - Running pre-action listener: _resource_record_pre_action 03:25:25 INFO - Running main action method: clobber 03:25:25 INFO - rmtree: /builds/slave/test/build 03:25:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:26 INFO - Running post-action listener: _resource_record_post_action 03:25:26 INFO - [mozharness: 2017-09-12 10:25:26.748343Z] Finished clobber step (success) 03:25:26 INFO - [mozharness: 2017-09-12 10:25:26.748439Z] Running read-buildbot-config step. 03:25:26 INFO - Running pre-action listener: _resource_record_pre_action 03:25:26 INFO - Running main action method: read_buildbot_config 03:25:26 INFO - Using buildbot properties: 03:25:26 INFO - { 03:25:26 INFO - "project": "", 03:25:26 INFO - "product": "firefox", 03:25:26 INFO - "who": "archaeopteryx@coole-files.de", 03:25:26 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:25:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:25:26 INFO - "stage_platform": "linux64-qr", 03:25:26 INFO - "basedir": "/builds/slave/test", 03:25:26 INFO - "buildnumber": 43, 03:25:26 INFO - "platform": "ubuntu64_hw_qr", 03:25:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:26 INFO - "slavebuilddir": "test", 03:25:26 INFO - "taskId": "RuVFAg2ISrCvWR4OkBXWpQ", 03:25:26 INFO - "branch": "mozilla-central", 03:25:26 INFO - "script_repo_revision": "production", 03:25:26 INFO - "revision": "175f1366daee80cde53386a4627402ed3af4c038", 03:25:26 INFO - "slavename": "talos-linux64-ix-038", 03:25:26 INFO - "repo_path": "mozilla-central" 03:25:26 INFO - } 03:25:26 INFO - Finding installer, test and symbols from parent task. 03:25:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RuVFAg2ISrCvWR4OkBXWpQ'}, attempt #1 03:25:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RuVFAg2ISrCvWR4OkBXWpQ'}, attempt #1 03:25:27 INFO - Task dependencies: c8J8p6RuRZ-xxUSm_NtOkg 03:25:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg'}, attempt #1 03:25:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip 03:25:28 INFO - Running post-action listener: _resource_record_post_action 03:25:28 INFO - [mozharness: 2017-09-12 10:25:28.106674Z] Finished read-buildbot-config step (success) 03:25:28 INFO - [mozharness: 2017-09-12 10:25:28.106889Z] Running download-and-extract step. 03:25:28 INFO - Running pre-action listener: _resource_record_pre_action 03:25:28 INFO - Running main action method: download_and_extract 03:25:28 INFO - mkdir: /builds/slave/test/build/tests 03:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:28 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:28 INFO - Downloading https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:25:28 INFO - Downloaded 989 bytes. 03:25:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:28 INFO - Using the following test package requirements: 03:25:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:28 INFO - u'common': [u'target.common.tests.zip'], 03:25:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:28 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:28 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:28 INFO - u'target.web-platform.tests.tar.gz'], 03:25:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip 03:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip into memory 03:25:29 INFO - Content-Length response header: 55043807 03:25:29 INFO - Bytes received: 55043807 03:25:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip 03:25:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:25:41 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip into memory 03:25:42 INFO - Content-Length response header: 14499231 03:25:42 INFO - Bytes received: 14499231 03:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:42 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:42 INFO - Downloading https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:25:44 INFO - Downloaded 63128717 bytes. 03:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:44 INFO - mkdir: /builds/slave/test/properties 03:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:44 INFO - Contents: 03:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:44 INFO - Running post-action listener: _resource_record_post_action 03:25:44 INFO - Running post-action listener: find_tests_for_verification 03:25:44 INFO - Running post-action listener: set_extra_try_arguments 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.043046Z] Finished download-and-extract step (success) 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.043144Z] Running populate-webroot step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: populate_webroot 03:25:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tresize', 03:25:44 INFO - 'tcanvasmark']}, 03:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['dromaeo_css', 03:25:44 INFO - 'kraken']}, 03:25:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['damp', 'tps']}, 03:25:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['damp', 'tps']}, 03:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['dromaeo_dom']}, 03:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['basic_compositor_video', 03:25:44 INFO - 'glvideo']}, 03:25:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['ts_paint_webext', 03:25:44 INFO - 'tp5o_webext']}, 03:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:44 INFO - 'ts_paint', 03:25:44 INFO - 'tpaint', 03:25:44 INFO - 'sessionrestore', 03:25:44 INFO - 'sessionrestore_many_windows', 03:25:44 INFO - 'sessionrestore_no_auto_restore', 03:25:44 INFO - 'tabpaint']}, 03:25:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['a11yr', 03:25:44 INFO - 'ts_paint', 03:25:44 INFO - 'tpaint', 03:25:44 INFO - 'sessionrestore', 03:25:44 INFO - 'sessionrestore_many_windows', 03:25:44 INFO - 'sessionrestore_no_auto_restore', 03:25:44 INFO - 'tabpaint']}, 03:25:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['bloom_basic']}, 03:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:44 INFO - 'tsvgr_opacity', 03:25:44 INFO - 'tart', 03:25:44 INFO - 'tscrollx', 03:25:44 INFO - 'tsvg_static']}, 03:25:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tsvgx', 03:25:44 INFO - 'tsvgr_opacity', 03:25:44 INFO - 'tart', 03:25:44 INFO - 'tscrollx', 03:25:44 INFO - 'tsvg_static']}, 03:25:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo'], 03:25:44 INFO - 'tests': ['tp5o']}, 03:25:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo', 03:25:44 INFO - '--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:44 INFO - 'talos_options': ['--stylo-threads=1', 03:25:44 INFO - '--mitmproxy', 03:25:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:44 INFO - '--firstNonBlankPaint'], 03:25:44 INFO - 'tests': ['tp6_google', 03:25:44 INFO - 'tp6_youtube', 03:25:44 INFO - 'tp6_amazon', 03:25:44 INFO - 'tp6_facebook']}, 03:25:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--xperf_path', 03:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:44 INFO - 'tests': ['tp5n']}, 03:25:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:44 INFO - 'talos_options': ['--disable-stylo', 03:25:44 INFO - '--xperf_path', 03:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:44 INFO - 'tests': ['tp5n']}}} 03:25:44 INFO - Running post-action listener: _resource_record_post_action 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.058062Z] Finished populate-webroot step (success) 03:25:44 INFO - [mozharness: 2017-09-12 10:25:44.058152Z] Running create-virtualenv step. 03:25:44 INFO - Running pre-action listener: _resource_record_pre_action 03:25:44 INFO - Running main action method: create_virtualenv 03:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:25:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:46 INFO - Installing pip...............done. 03:25:46 INFO - Return code: 0 03:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:46 INFO - Reading from file tmpfile_stdout 03:25:46 INFO - Output received: 03:25:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:25:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:46 INFO - Using env: {'DISPLAY': ':0', 03:25:46 INFO - 'HOME': '/home/cltbld', 03:25:46 INFO - 'LANG': 'en_US.UTF-8', 03:25:46 INFO - 'LANGUAGE': 'en_US:en', 03:25:46 INFO - 'LOGNAME': 'cltbld', 03:25:46 INFO - 'MAIL': '/var/mail/cltbld', 03:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:46 INFO - 'MOZ_NO_REMOTE': '1', 03:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:46 INFO - 'NO_EM_RESTART': '1', 03:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:46 INFO - 'PWD': '/builds/slave/test', 03:25:46 INFO - 'SHELL': '/bin/bash', 03:25:46 INFO - 'SHLVL': '1', 03:25:46 INFO - 'TERM': 'linux', 03:25:46 INFO - 'TMOUT': '86400', 03:25:46 INFO - 'USER': 'cltbld', 03:25:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:46 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:25:49 INFO - Downloading/unpacking pip>=1.5 03:25:49 INFO - Running setup.py egg_info for package pip 03:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:49 INFO - Installing collected packages: pip 03:25:49 INFO - Found existing installation: pip 1.1 03:25:49 INFO - Uninstalling pip: 03:25:49 INFO - Successfully uninstalled pip 03:25:49 INFO - Running setup.py install for pip 03:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:25:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:25:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:25:49 INFO - Successfully installed pip 03:25:49 INFO - Cleaning up... 03:25:49 INFO - Return code: 0 03:25:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:49 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:49 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 03:25:49 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 03:25:49 INFO - Using env: {'DISPLAY': ':0', 03:25:49 INFO - 'HOME': '/home/cltbld', 03:25:49 INFO - 'LANG': 'en_US.UTF-8', 03:25:49 INFO - 'LANGUAGE': 'en_US:en', 03:25:49 INFO - 'LOGNAME': 'cltbld', 03:25:49 INFO - 'MAIL': '/var/mail/cltbld', 03:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:49 INFO - 'MOZ_NO_REMOTE': '1', 03:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:49 INFO - 'NO_EM_RESTART': '1', 03:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:49 INFO - 'PWD': '/builds/slave/test', 03:25:49 INFO - 'SHELL': '/bin/bash', 03:25:49 INFO - 'SHLVL': '1', 03:25:49 INFO - 'TERM': 'linux', 03:25:49 INFO - 'TMOUT': '86400', 03:25:49 INFO - 'USER': 'cltbld', 03:25:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:49 INFO - '_': '/tools/buildbot/bin/python'} 03:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:52 INFO - Downloading/unpacking psutil>=3.1.1 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:53 INFO - Installing collected packages: psutil 03:25:53 INFO - Running setup.py install for psutil 03:25:53 INFO - building 'psutil._psutil_linux' extension 03:25:53 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 03:25:55 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 03:25:55 INFO - building 'psutil._psutil_posix' extension 03:25:55 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 03:25:55 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 03:25:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:56 INFO - Successfully installed psutil 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:56 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')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 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')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:56 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 03:25:56 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 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:56 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 03:25:56 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 03:25:56 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 03:25:56 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 03:25:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:57 INFO - Installing collected packages: mozsystemmonitor 03:25:57 INFO - Running setup.py install for mozsystemmonitor 03:25:57 INFO - Successfully installed mozsystemmonitor 03:25:57 INFO - Cleaning up... 03:25:57 INFO - Return code: 0 03:25:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:25:57 INFO - Using env: {'DISPLAY': ':0', 03:25:57 INFO - 'HOME': '/home/cltbld', 03:25:57 INFO - 'LANG': 'en_US.UTF-8', 03:25:57 INFO - 'LANGUAGE': 'en_US:en', 03:25:57 INFO - 'LOGNAME': 'cltbld', 03:25:57 INFO - 'MAIL': '/var/mail/cltbld', 03:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:57 INFO - 'MOZ_NO_REMOTE': '1', 03:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:57 INFO - 'NO_EM_RESTART': '1', 03:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:57 INFO - 'PWD': '/builds/slave/test', 03:25:57 INFO - 'SHELL': '/bin/bash', 03:25:57 INFO - 'SHLVL': '1', 03:25:57 INFO - 'TERM': 'linux', 03:25:57 INFO - 'TMOUT': '86400', 03:25:57 INFO - 'USER': 'cltbld', 03:25:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:57 INFO - '_': '/tools/buildbot/bin/python'} 03:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:57 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:57 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 03:25:57 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 03:25:57 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 03:25:57 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 03:25:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:58 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 03:25:58 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 03:25:58 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 03:25:58 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 03:25:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:59 INFO - warning: no files found matching '*.txt' 03:25:59 INFO - no previously-included directories found matching 'build' 03:25:59 INFO - no previously-included directories found matching 'dist' 03:25:59 INFO - no previously-included directories found matching '.git*' 03:25:59 INFO - Installing collected packages: jsonschema, functools32 03:25:59 INFO - Running setup.py install for functools32 03:25:59 INFO - warning: no files found matching '*.txt' 03:25:59 INFO - no previously-included directories found matching 'build' 03:25:59 INFO - no previously-included directories found matching 'dist' 03:25:59 INFO - no previously-included directories found matching '.git*' 03:25:59 INFO - Successfully installed jsonschema functools32 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:59 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')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 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')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:59 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 03:25:59 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 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:59 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')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 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')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:25:59 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 03:25:59 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 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:59 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 03:25:59 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 03:25:59 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 03:25:59 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 03:26:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:00 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 03:26:00 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 03:26:00 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 03:26:00 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 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:01 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 03:26:01 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 03:26:01 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 03:26:01 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 03:26:01 INFO - Downloading docopt-0.6.1.tar.gz 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:01 INFO - Running setup.py install for blobuploader 03:26:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:01 INFO - Running setup.py install for requests 03:26:01 INFO - Running setup.py install for docopt 03:26:01 INFO - Successfully installed blobuploader requests docopt 03:26:01 INFO - Cleaning up... 03:26:01 INFO - Return code: 0 03:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:01 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')]} 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:01 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')]} 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:02 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:26:02 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 03:26:02 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 03:26:02 INFO - Using env: {'DISPLAY': ':0', 03:26:02 INFO - 'HOME': '/home/cltbld', 03:26:02 INFO - 'LANG': 'en_US.UTF-8', 03:26:02 INFO - 'LANGUAGE': 'en_US:en', 03:26:02 INFO - 'LOGNAME': 'cltbld', 03:26:02 INFO - 'MAIL': '/var/mail/cltbld', 03:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:02 INFO - 'MOZ_NO_REMOTE': '1', 03:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:02 INFO - 'NO_EM_RESTART': '1', 03:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:02 INFO - 'PWD': '/builds/slave/test', 03:26:02 INFO - 'SHELL': '/bin/bash', 03:26:02 INFO - 'SHLVL': '1', 03:26:02 INFO - 'TERM': 'linux', 03:26:02 INFO - 'TMOUT': '86400', 03:26:02 INFO - 'USER': 'cltbld', 03:26:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:02 INFO - '_': '/tools/buildbot/bin/python'} 03:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Running setup.py (path:/tmp/pip-Wrhxsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Running setup.py (path:/tmp/pip-MIefiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Running setup.py (path:/tmp/pip-3u3fND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 INFO - Running setup.py (path:/tmp/pip-QyJibF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:02 INFO - Running setup.py (path:/tmp/pip-QAHgWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:02 INFO - Running setup.py (path:/tmp/pip-ZPvZ15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:02 INFO - Running setup.py (path:/tmp/pip-_HmDb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:02 INFO - Running setup.py (path:/tmp/pip-yhOZz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:02 INFO - Running setup.py (path:/tmp/pip-ybchl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:02 INFO - Running setup.py (path:/tmp/pip-IRfe6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:02 INFO - Running setup.py (path:/tmp/pip-n6cKOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Running setup.py (path:/tmp/pip-ODAPPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Running setup.py (path:/tmp/pip-vrDhZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Running setup.py (path:/tmp/pip-e8cDAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Running setup.py (path:/tmp/pip-fQL8eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Running setup.py (path:/tmp/pip-_pozTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Running setup.py (path:/tmp/pip-C1Rh4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:03 INFO - Running setup.py install for manifestparser 03:26:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:03 INFO - Running setup.py install for mozcrash 03:26:03 INFO - Running setup.py install for mozdebug 03:26:03 INFO - Running setup.py install for mozdevice 03:26:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:03 INFO - Running setup.py install for mozfile 03:26:03 INFO - Running setup.py install for mozhttpd 03:26:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozinfo 03:26:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozInstall 03:26:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozleak 03:26:04 INFO - Running setup.py install for mozlog 03:26:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for moznetwork 03:26:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozprocess 03:26:04 INFO - Running setup.py install for mozprofile 03:26:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozrunner 03:26:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:04 INFO - Running setup.py install for mozscreenshot 03:26:04 INFO - Running setup.py install for moztest 03:26:05 INFO - Running setup.py install for mozversion 03:26:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:05 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')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 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')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:26:05 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 03:26:05 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 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 INFO - Running setup.py (path:/tmp/pip-7KXiUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:05 INFO - Running setup.py (path:/tmp/pip-z3LRPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:05 INFO - Running setup.py (path:/tmp/pip-h2UY9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:05 INFO - Running setup.py (path:/tmp/pip-fYb5PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:05 INFO - Running setup.py (path:/tmp/pip-JsbAKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:05 INFO - Running setup.py (path:/tmp/pip-esF7Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:05 INFO - Running setup.py (path:/tmp/pip-tXpZiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:05 INFO - Running setup.py (path:/tmp/pip-Luq5DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:05 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)) 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:05 INFO - Running setup.py (path:/tmp/pip-7Xoav3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Running setup.py (path:/tmp/pip-8yZAX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Running setup.py (path:/tmp/pip-vNiXAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Running setup.py (path:/tmp/pip-q7rs1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Running setup.py (path:/tmp/pip-b4Am25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 INFO - Running setup.py (path:/tmp/pip-iE8F0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:06 INFO - Running setup.py (path:/tmp/pip-A4hxtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:06 INFO - Running setup.py (path:/tmp/pip-f50t1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:06 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)) 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:06 INFO - Running setup.py (path:/tmp/pip-8OA_a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 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)) 03:26:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:06 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 03:26:06 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 03:26:06 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 03:26:06 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 03:26:07 INFO - Downloading blessings-1.6.tar.gz 03:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:07 INFO - Installing collected packages: blessings 03:26:07 INFO - Running setup.py install for blessings 03:26:07 INFO - Successfully installed blessings 03:26:07 INFO - Cleaning up... 03:26:07 INFO - Return code: 0 03:26:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:08 INFO - Reading from file tmpfile_stdout 03:26:08 INFO - Current package versions: 03:26:08 INFO - argparse == 1.2.1 03:26:08 INFO - blessings == 1.6 03:26:08 INFO - blobuploader == 1.2.4 03:26:08 INFO - docopt == 0.6.1 03:26:08 INFO - functools32 == 3.2.3-2 03:26:08 INFO - jsonschema == 2.5.1 03:26:08 INFO - manifestparser == 1.1 03:26:08 INFO - mozInstall == 1.13 03:26:08 INFO - mozcrash == 1.0 03:26:08 INFO - mozdebug == 0.1 03:26:08 INFO - mozdevice == 0.51 03:26:08 INFO - mozfile == 1.2 03:26:08 INFO - mozhttpd == 0.7 03:26:08 INFO - mozinfo == 0.10 03:26:08 INFO - mozleak == 0.1 03:26:08 INFO - mozlog == 3.5 03:26:08 INFO - moznetwork == 0.27 03:26:08 INFO - mozprocess == 0.25 03:26:08 INFO - mozprofile == 0.28 03:26:08 INFO - mozrunner == 6.13 03:26:08 INFO - mozscreenshot == 0.1 03:26:08 INFO - mozsystemmonitor == 0.3 03:26:08 INFO - moztest == 0.8 03:26:08 INFO - mozversion == 1.4 03:26:08 INFO - psutil == 3.1.1 03:26:08 INFO - requests == 1.2.3 03:26:08 INFO - wsgiref == 0.1.2 03:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:08 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')]} 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:08 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')]} 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:08 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:26:08 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 03:26:08 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 03:26:08 INFO - Using env: {'DISPLAY': ':0', 03:26:08 INFO - 'HOME': '/home/cltbld', 03:26:08 INFO - 'LANG': 'en_US.UTF-8', 03:26:08 INFO - 'LANGUAGE': 'en_US:en', 03:26:08 INFO - 'LOGNAME': 'cltbld', 03:26:08 INFO - 'MAIL': '/var/mail/cltbld', 03:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:08 INFO - 'MOZ_NO_REMOTE': '1', 03:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:08 INFO - 'NO_EM_RESTART': '1', 03:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:08 INFO - 'PWD': '/builds/slave/test', 03:26:08 INFO - 'SHELL': '/bin/bash', 03:26:08 INFO - 'SHLVL': '1', 03:26:08 INFO - 'TERM': 'linux', 03:26:08 INFO - 'TMOUT': '86400', 03:26:08 INFO - 'USER': 'cltbld', 03:26:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:08 INFO - '_': '/tools/buildbot/bin/python'} 03:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 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)) 03:26:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:08 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 03:26:08 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 03:26:08 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 03:26:08 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 03:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:09 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)) 03:26:09 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)) 03:26:09 INFO - Installing collected packages: simplejson 03:26:09 INFO - Running setup.py install for simplejson 03:26:09 INFO - building 'simplejson._speedups' extension 03:26:09 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 03:26:10 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 03:26:10 INFO - Successfully installed simplejson 03:26:10 INFO - Cleaning up... 03:26:10 INFO - Return code: 0 03:26:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:10 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')]} 03:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:10 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')]} 03:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:10 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 0xc601f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe29a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, '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': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', '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 03:26:10 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 03:26:10 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 03:26:10 INFO - Using env: {'DISPLAY': ':0', 03:26:10 INFO - 'HOME': '/home/cltbld', 03:26:10 INFO - 'LANG': 'en_US.UTF-8', 03:26:10 INFO - 'LANGUAGE': 'en_US:en', 03:26:10 INFO - 'LOGNAME': 'cltbld', 03:26:10 INFO - 'MAIL': '/var/mail/cltbld', 03:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:10 INFO - 'MOZ_NO_REMOTE': '1', 03:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:10 INFO - 'NO_EM_RESTART': '1', 03:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:10 INFO - 'PWD': '/builds/slave/test', 03:26:10 INFO - 'SHELL': '/bin/bash', 03:26:10 INFO - 'SHLVL': '1', 03:26:10 INFO - 'TERM': 'linux', 03:26:10 INFO - 'TMOUT': '86400', 03:26:10 INFO - 'USER': 'cltbld', 03:26:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:10 INFO - '_': '/tools/buildbot/bin/python'} 03:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:10 INFO - Cleaning up... 03:26:10 INFO - Return code: 0 03:26:10 INFO - Running post-action listener: _resource_record_post_action 03:26:10 INFO - Running post-action listener: _start_resource_monitoring 03:26:10 INFO - Starting resource monitoring. 03:26:10 INFO - [mozharness: 2017-09-12 10:26:10.919216Z] Finished create-virtualenv step (success) 03:26:10 INFO - [mozharness: 2017-09-12 10:26:10.919729Z] Running install step. 03:26:10 INFO - Running pre-action listener: _resource_record_pre_action 03:26:10 INFO - Running main action method: install 03:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:11 INFO - Reading from file tmpfile_stdout 03:26:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:11 INFO - Reading from file tmpfile_stdout 03:26:11 INFO - Output received: 03:26:11 INFO - Usage: mozinstall [options] installer 03:26:11 INFO - Options: 03:26:11 INFO - -h, --help show this help message and exit 03:26:11 INFO - -d DEST, --destination=DEST 03:26:11 INFO - Directory to install application into. [default: 03:26:11 INFO - "/builds/slave/test"] 03:26:11 INFO - --app=APP Application being installed. [default: firefox] 03:26:11 INFO - mkdir: /builds/slave/test/build/application 03:26:11 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'] 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:26:27 INFO - Reading from file tmpfile_stdout 03:26:27 INFO - Output received: 03:26:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:27 INFO - Running post-action listener: _resource_record_post_action 03:26:27 INFO - [mozharness: 2017-09-12 10:26:27.840771Z] Finished install step (success) 03:26:27 INFO - [mozharness: 2017-09-12 10:26:27.840915Z] Running setup-mitmproxy step. 03:26:27 INFO - Running pre-action listener: _resource_record_pre_action 03:26:27 INFO - Running main action method: setup_mitmproxy 03:26:27 INFO - Skipping: mitmproxy is not required 03:26:27 INFO - Running post-action listener: _resource_record_post_action 03:26:27 INFO - [mozharness: 2017-09-12 10:26:27.841683Z] Finished setup-mitmproxy step (success) 03:26:27 INFO - [mozharness: 2017-09-12 10:26:27.841902Z] Running run-tests step. 03:26:27 INFO - Running pre-action listener: _resource_record_pre_action 03:26:27 INFO - Running pre-action listener: _set_gcov_prefix 03:26:27 INFO - Running main action method: run_tests 03:26:27 WARNING - Try message not found. 03:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:27 INFO - Python 2.7.3 03:26:27 INFO - Return code: 0 03:26:27 INFO - grabbing minidump binary from tooltool 03:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:27 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 0xfd0090>, '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 0xfd0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:27 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 03:26:27 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 03:26:27 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 03:26:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:28 INFO - Return code: 0 03:26:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:28 INFO - ENV: RUST_BACKTRACE is now full 03:26:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:28 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/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:26:28 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/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 03:26:28 INFO - Using env: {'DISPLAY': ':0', 03:26:28 INFO - 'HOME': '/home/cltbld', 03:26:28 INFO - 'LANG': 'en_US.UTF-8', 03:26:28 INFO - 'LANGUAGE': 'en_US:en', 03:26:28 INFO - 'LOGNAME': 'cltbld', 03:26:28 INFO - 'MAIL': '/var/mail/cltbld', 03:26:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:28 INFO - 'MOZ_ACCELERATED': '1', 03:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:28 INFO - 'MOZ_NO_REMOTE': '1', 03:26:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:28 INFO - 'MOZ_WEBRENDER': '1', 03:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:28 INFO - 'NO_EM_RESTART': '1', 03:26:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:28 INFO - 'PWD': '/builds/slave/test', 03:26:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:28 INFO - 'RUST_BACKTRACE': 'full', 03:26:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:28 INFO - 'SHELL': '/bin/bash', 03:26:28 INFO - 'SHLVL': '1', 03:26:28 INFO - 'TERM': 'linux', 03:26:28 INFO - 'TMOUT': '86400', 03:26:28 INFO - 'USER': 'cltbld', 03:26:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:28 INFO - '_': '/tools/buildbot/bin/python'} 03:26:28 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/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 03:26:28 INFO - mozversion application_buildid: 20170912093323 03:26:28 INFO - mozversion application_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:28 INFO - mozversion application_display_name: Nightly 03:26:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:28 INFO - mozversion application_name: Firefox 03:26:28 INFO - mozversion application_remotingname: firefox 03:26:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:28 INFO - mozversion application_vendor: Mozilla 03:26:28 INFO - mozversion application_version: 57.0a1 03:26:28 INFO - mozversion platform_buildid: 20170912093323 03:26:28 INFO - mozversion platform_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:28 INFO - mozversion platform_version: 57.0a1 03:26:28 INFO - using testdate: 1505211988 03:26:28 INFO - actual date: 1505211988 03:26:28 INFO - starting webserver on 'localhost:36268' 03:26:28 INFO - SUITE-START | Running 2 tests 03:26:28 INFO - TEST-START | dromaeo_css 03:26:28 INFO - Initialising browser for dromaeo_css test... 03:26:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36268/getInfo.html -profile /tmp/tmpSK88NX/profile 03:26:28 INFO - TEST-INFO | started process 3650 (/builds/slave/test/build/application/firefox/firefox http://localhost:36268/getInfo.html) 03:26:43 INFO - TEST-INFO | 3650: exit 0 03:26:43 INFO - Browser initialized. 03:26:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:43 INFO - Using env: {'DISPLAY': ':0', 03:26:43 INFO - 'HOME': '/home/cltbld', 03:26:43 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:43 INFO - 'LANG': 'en_US.UTF-8', 03:26:43 INFO - 'LANGUAGE': 'en_US:en', 03:26:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:43 INFO - 'LOGNAME': 'cltbld', 03:26:43 INFO - 'MAIL': '/var/mail/cltbld', 03:26:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:43 INFO - 'MOZ_ACCELERATED': '1', 03:26:43 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:43 INFO - 'MOZ_NO_REMOTE': '1', 03:26:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:43 INFO - 'MOZ_WEBRENDER': '1', 03:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:43 INFO - 'NO_EM_RESTART': '1', 03:26:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:43 INFO - 'PWD': '/builds/slave/test', 03:26:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:43 INFO - 'RUST_BACKTRACE': 'full', 03:26:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:43 INFO - 'SHELL': '/bin/bash', 03:26:43 INFO - 'SHLVL': '1', 03:26:43 INFO - 'TERM': 'linux', 03:26:43 INFO - 'TMOUT': '86400', 03:26:43 INFO - 'USER': 'cltbld', 03:26:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:43 INFO - '_': '/tools/buildbot/bin/python'} 03:26:43 INFO - TEST-INFO | started process 3859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSK88NX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:44 INFO - PID 3859 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:26:44 INFO - PID 3859 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:26:44 INFO - PID 3859 | 03:26:44 INFO - PID 3859 | (/builds/slave/test/build/application/firefox/firefox:3921): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:44 INFO - PID 3859 | 03:26:55 INFO - PID 3859 | RSS: Main: 214654976 03:26:55 INFO - PID 3859 | 03:29:53 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36268/tests/dromaeo/cssquery-ext.html) 03:29:54 INFO - PID 3859 | RSS: Main: 221773824 03:29:54 INFO - PID 3859 | 03:32:56 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-ext.html (next: http://localhost:36268/tests/dromaeo/cssquery-jquery.html) 03:32:57 INFO - PID 3859 | RSS: Main: 220753920 03:32:57 INFO - PID 3859 | 03:35:59 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36268/tests/dromaeo/cssquery-mootools.html) 03:35:59 INFO - PID 3859 | RSS: Main: 223784960 03:35:59 INFO - PID 3859 | 03:39:01 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36268/tests/dromaeo/cssquery-prototype.html) 03:39:02 INFO - PID 3859 | RSS: Main: 219070464 03:39:02 INFO - PID 3859 | 03:42:06 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36268/tests/dromaeo/cssquery-yui.html) 03:42:06 INFO - PID 3859 | RSS: Main: 223686656 03:42:06 INFO - PID 3859 | 03:45:08 INFO - PID 3859 | Cycle 1(1): loaded http://localhost:36268/tests/dromaeo/cssquery-yui.html (next: http://localhost:36268/tests/dromaeo/cssquery-dojo.html) 03:45:09 INFO - PID 3859 | RSS: Main: 228573184 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | __start_tp_report 03:45:09 INFO - PID 3859 | _x_x_mozilla_page_load 03:45:09 INFO - PID 3859 | _x_x_mozilla_page_load_details 03:45:09 INFO - PID 3859 | |i|pagename|runs| 03:45:09 INFO - PID 3859 | |0;dojo.html;3092.845357732113;3098.876044958202;3102;3135.592372991512;3148.291634382263;6091.878162436759;6229.252489701236;6288.937110628893;6303.338149494306;6342.175517182772;6158.322584515699;6209.503239740821;6216.937830621692;6221.657808820513;6242;5735.254416925804;5748.281464816898;5770.2210201622875;5791.015527360359;5863.384344643815;5814.8255552333285;5881.441263080001;5888.617239879415;5892.968730472172;5922.822315330525;5802.564807639444;5808.215890854723;5819.563532735041;5891.175235467038;5891.440313170264;5569.10894256921;5707;5738.225339579145;5784.913226301609;5834.970825145847;5704.4865962063195;5711.8000869969355;5740.311162660508;5766.308043034863;5784.942150578482;6111.908321375183;6118.449339559416;6153.784617538409;6184.041473571604;6304.495640348807;6517.4134327910715;6569.113169722074;6576.80269591913;6582.736690532373;6588.670566471706;6612.867742645169;6626.536142470029;6645;6765.932340676629;6776.288489708559;6225.408586184305;6271.4042165994615;6285.528585356116;6289.528285378569;6354.142190804275;6618.96690516554;6904.689288982008;6926.411255043277;6978.197507286625;7001.579905205704;6471.5146364022885;6485.059666348353;6555.4427873631275;6603.042558828943;6608.438282745924;6690.799276021728;6693.631850248185;6751.594904305757;6755.392014718699;6775.3902148805855;6657.40083392497;6696.363845434676;6756.560823546453;6758.324167583202;6764.797056088325;6543.214814222324;6663.866722665616;6676.699548520328;6676.83307917306;6758.695858686371;5257.474252574789;5266.631335806457;5321.6540924839765;5323.973380133152;5335.62650614461;4614.907701846011;4668.15973124834;4682.227432473672;4702.905941881143;4708.105459962596;5676.4323567642905;5743.655380677173;5795.971020144872;5836.445537673914;5848.853778655568;6565.507586930999;6679.599224046573;6726.764563240263;6758.93241067583;6766.052752614638;5777.8555536111935;5789;5790.768369265266;5795.1017592273265;5795.420457954255;5764.193012978187;5794.623349482355;5813.331466881278;5819.301683797887;5837.591368604242;6527.54307198501;6532.6733663316645;6596.571222870498;6602.372774586406;6609.86780264392;6547.541672083099;6691.1636045494315;6727.798166055026;6827.692753825991;6833.453323734089;6366.045093236052;6465.2564955030775;6532.379423954717;6539.901901471387;6552.049952756728;6600.900986485302;6672.065910772592;6675.866482670416;6684.799456016327;6687.264400915993;6761.729530818712;6780.559263647847;6824.2152152503095;6844.691988860613;6856.108705868205;6482.870342593216;6497.610143391223;6499.38255865692;6567.441767449629;6589.901151482636;6377.7767778127545;6480.25477070143;6491.935080649133;6571.638559879252;6583.3087525811015;6421.775237866652;6460.903086453801;6483.773067942788;6501.9674901625185;6522.902156467562;6548.3124271952665;6608.603483790988;6660.467162626881;6667.533272670867;6677.198736151693;6187.566870319034;6312.4634406076;6360.077788720702;6404.71178796946;6447.323031081856 03:45:09 INFO - PID 3859 | |1;ext.html;857.3484152044446;875.4047247871449;881.6253092435713;883.2713011765295;887.862381330894;38525.22949541007;41782;42285;42478;42564.36153457701;38053.61946380536;38336;38446;38482;38611.420828687595;6857.348551887588;6859.279775623562;6972.965135174317;6991.685374158163;7029.718811247544;6993.6503174841055;7076.292370762908;7080.539764915264;7082.043924070262;7083.716651333966;7016.508844380895;7026.910828821541;7037.437005039585;7062.223155452896;7065.434765218796;6963.79108626742;7021.122359705037;7466.440016998747;7666.808329791744;7719.498232614918;7640.426967977424;7707.421943354271;7710.537367757953;7712.035995500562;7717.845643087163;37568.24863502742;37666.62333376686;37748.24503509942;39051.41422878659;39868.80065599683;3480.738944579167;3516.384632689269;3519.7184225261917;3522.8766993155373;3528.3648943190215;32510.349793004243;32589.18527036843;32674.6732532674;32707.345853083043;32760;5122.846314610568;5181.611379146579;5201.08980928336;5214.217867319894;5298.947010529884;182796;184638;187580;187650.99999999863;187858;41410.37884431736;42087.36868946968;48803;49447.50552494501;50192;52605.2109218362;52747.20879186815;52907.470925290254;53075;53102;16263.59341016484;16288.511344659679;16291.837081629032;16351.26419311134;16362.427315043917;13187.076904616584;13356.265405402795;13385.19688818674;13431.731365372832;13555.796663050061;14379.137251764927;14401.78397324041;14512.346944387527;14547.563573092824;14647.92676036613;5746.827595172152;5793.971030144822;5806.593538452352;5881.558883083786;6058.636481811105;1007.9798404031878;1014.4065721552827;1029.6447725534679;1034.4517405774952;1048.219076787798;22697.432564186027;23015.88492057529;23124.65313020306;23139.3058208254;23416.64875026876;1106.7233191702076;1125.4204084896285;1126.307320997597;1140.1448913315014;1142.9998751092794;12354.25874447536;12373.257604543576;12377.071719621064;12429.937850310691;12482.50069997208;223137;224043;224539;224973;226270;52763.472365276626;52831.47168528265;53358;53507.46492535103;53523.732381337846;1434.9210793406255;1465.6922046370169;1480.2746654139394;1490.6720521485256;1503.646643038885;22269.331920042423;22419.77580224177;22600.434989124744;22691.886540567193;22938.770612293665;37172.256554869295;37187;37619;37694.62305376911;37743.62256377401;196543;198955;200085;201131;201185;34693.13267168341;35129.64870351366;35818.28363432769;35944.64055359518;36089.639103609676;44257;45217.09565808731;45736;45828.541714582425;47074;33496.66503335033;33833.66166338305;33993.320133596695;34076.65923340735;34274;33073.669263307056;33255.334893301515;33344.1663958403;33346.83326583351;33803.15492112717;37866;37873.81063094667;38024.23951520899;38048.42927356037;38270.23459530738;32848.34303313873;32849.83575082205;32863.342733144724;32892;33173.17067073342;23345.608414917067;23459.530809384058;23717.762822371555;23943.640845387683;24003.639945400482 03:45:09 INFO - PID 3859 | |2;jquery.html;551.4099913092992;558.8938101760665;566.56091529065;569.6382796923953;590.7725525672618;21796.45508862279;22461.101555937785;22631.66052509214;22692.09231630735;22708.432289192777;23599.41001474964;24063.39841503963;24457.87771061142;25655.48689026223;25806.74193258067;6333.873322533546;6397.072424498445;6418.550701450877;6424.775132870351;6460.547761656686;6095.207623009025;6122.816315510542;6167.9074813877605;6171.382861713815;6255.530835187356;6570.63861487618;6571.835704107411;6575.638339891304;6576.704048317813;6582.9670851645915;6567.474602031826;6570.8685826283445;6571.80284591463;6578.80263592093;6581.177352830896;6571.145751052381;6887.931120688779;6909.689063992132;6961.895571566431;6983.790486285419;31198.532022019688;31452.37095258082;31726.206844828834;31729.84135079333;31741;2075.7197778299887;2099.643060679688;2102.6845973104005;2103.978960210394;2112.7992840680113;20292.391228263175;20606.381808545768;20961.790382096136;21097.789022109737;21437.892810536003;2451.374899400659;2487.8182863140046;2493.9002439902383;2555.5911054231233;2560.0527804712187;118684;122502.38748806289;123569.38215308955;123614;137576;18775.530611734543;20822;21700.240491582717;21978.670319945213;22155.999999999676;43479.56520434818;43773.12453750907;43810;43886.78056609697;43942;11205;11329.773404531863;11354.432278386048;11419.429028548706;11446.94276528612;9304.16262536375;9363.25129700711;9399.671011514563;9494.287928405398;9556.423190173544;10953.507092180871;11074.833877491845;11124.555017799197;11341.489632966537;11560.421978901022;3730.1607138393642;4058.6753059755147;4117.279476091672;4328.242557552416;4403.9779801100785;954.1365064616533;958.6261358070219;966.429806414219;972.863799068131;983.9016098390103;19404.499492670115;19539.511512212022;19641.214351425784;19826;20279;1029.4183786160795;1032.2825636182781;1037.232447988483;1038.6676263595728;1039.3867618105355;10794.352338859693;11124.777504449865;11156.944215278872;11252.718682033015;11427.428628568538;477458;488217;489655;490458.5477072592;492000.13997130503;112380;113748;114612;114778.42610787059;116169.41915290538;1126.318577260762;1134.9773004539863;1160.1936654025371;1167.229628445222;1170.777552265067;17437.82562174362;17675.116244187997;17808.46574602764;17971.73042404391;18132.456026319232;52402.47597524129;53867.191992120934;54925.45074549203;55822.162667559205;55904;66187;67055.32944670686;67573.32426675867;67954;69030;19736.605267894847;19841;20034.59930801405;20285.49286267855;20303.28938487146;21953.23163689327;21966.560668786853;22355.664665030363;22364.77635223627;22377.66433503466;16942;17116.0586167757;17124.14379281056;17428.302867885144;18421.26314947387;15979.840201598301;16017.919910400373;16246.350145994027;16471.621560926455;17052.65894682124;17223.22495487681;17234.138293085045;18099.72850407271;18586.721199182295;18640.81359186391;19541.31605393861;19631.509212269808;19660.705089423955;19691;19807.900960495106;17393.782435229412;17652.382166624106;17672.381466648607;17923.73114403259;18094.909525452287 03:45:09 INFO - PID 3859 | |3;mootools.html;1326.7744483437814;1387.3618135657598;1395.8953078519114;1416.8228971378578;1428.4357678716908;14582.343794529244;15136;15214.695706085886;15235.923820380896;15318.693626127499;15068.32192551335;15070.924645376757;15086.396544138248;15185.0888946663;15207.92396038021;2743.890244390232;2778.097118436506;2817.4365126974585;2817.7464028237455;2830.5895645131445;2681.4637072585465;2691;2706.715794841533;2707.3367025078883;2709.810313278071;2548.4775620997743;2551.591745320749;2665.1471529110595;2857.214266076835;2865.1404578626434;2793.3016745813547;2820;2821.195959151632;2823.463541927048;2830.5754136879427;2632.7498887605648;2671.6793984721958;2677.866106694677;2683.195041487546;2809.592609071673;14894.255287235703;15045.623859403493;15203.695926081416;15227.238638068053;15228;7950.880736788953;8197.426180167391;8210.137935516805;8252.917470825336;8257.38069644773;5131;5304.416514183436;5400.1899715043055;5419.268398766156;5457.263269458612;1867.1224524473475;1944.3389247655723;1972.7829938706732;1992.810682985114;2006.6889632107047;26446.471070578675;26544.336391590172;26567.86716066446;26571.070012549662;26805.195844124708;6629.834254143685;6762.898556521656;6966.164060312795;6998.75504357345;7021.052157958712;16942.57643558921;16956.830431695773;17083.145842708065;17182.054986975836;17187.226574803914;7844.646990885424;8018.639161237758;8019.719309824245;8024.037115546172;8038.115807261197;7299.23358047408;7363.742269020666;7398.779201431704;7428.2571742825285;7480.289372509603;5152.4847515248175;5338.145896656516;5349.144136938071;5378.677279363251;5549.084401073858;1543.3440787665422;1549.5661214859858;1555.1524419191567;1558.9298481568358;1566.7728179414148;859.3812455032366;864.3949235535025;873.1835733588988;892.9776755581032;895.6909866096187;7261;7303.707851685979;7323.048003759477;7343.412526997828;7379;706.4560288577767;728.1153398620701;737.5832654550162;742.7103429662436;747.5253214209016;4463.839900936687;4518.502964673883;4673.556012178838;4939.678920870132;5005.399352077701;20525.17899284012;21191.576168476546;21651.783482164978;22343.55312893733;22363.66454503184;21084.262050828453;21653.458663533223;21736.565268694852;21932.342029739135;21937.890310548344;10793.730156745987;11458;11478.253913495597;11503.884961150281;11532.365719885487;8118.59407029658;8150.573649611413;8153.55155466455;8163.7142700005215;8195.262426381654;17937.282508699507;18570.350037748613;18852.811471885107;18996;19011.239550417828;17796.55508612295;19030.524236894187;19456.708149378053;19651.70522442193;20210.19159233673;10907.836382454429;10948.835767463335;11007.944960275147;11028.117750579773;11028.503717332578;13304.268265245504;13464.865351346361;13475.663108422368;13494.93252533731;13559.864401356255;11092.11263098934;11450.255733377304;11485;11517.712057198638;11665.650030499099;10493.160547156362;10520.421376824348;10758.193135515025;10792.352458852494;10904.618338358438;9234.538273086184;9382.530873456437;9384.67153649619;9452;9455.14903658674;7061.646917653994;7116.323949224816;7239.601821899846;7251.20236773965;7293.52592081513;6826.453883689393;6936.132983377078;6944.375006249462;6999.30006999296;7006.614636195059 03:45:09 INFO - PID 3859 | |4;prototype.html;499.5902182394598;506.860613331334;514.8532668189566;521.6504941689068;524.2686452398904;6311.968440157799;6380.553361264713;6385;6418.19772528434;6421.871562568752;6183.938160618403;6307;6343.841403964903;6344.3338449462835;6375.864085531352;5218.608604354669;5219.086659834533;5225.843224703265;5227.921581176285;5235.214717792323;5136.8715782105555;5171.50870667286;5194.558462530689;5213.791448342062;5236.136037553799;5015.423226328964;5108.471306703187;5133.409657889334;5144.819931302405;5233.790648374061;5162.380514338303;5175.715335656538;5197.752539390557;5247.23915032322;5260.658057226268;4843.4187897452175;4844.346013288232;4849.515048495157;4850.75746212688;4857.6599638025355;5957.667887240895;6114.694265286718;6151.907721384183;6192.411720886508;6242.406971337716;5941.70291485424;5975.880482390371;6012.3085845127935;6015.218021657157;6033.366496517846;6591.274959754423;6610.239822420435;6638.402543771083;6654.301298363651;6749.3250674932115;5065.6200784941275;5216.243644671501;5219.660722053054;5256.894862102775;5271.630985830993;6782.660866956682;6835.418989385908;6840.247572766992;6892.724291028403;6909.896351554731;5409.161579955114;5438.211459338374;5469.371022332403;5482.753276102585;5509.5041446270025;5526.171074338881;5526.944730552724;5526.972365138148;5575.330960284792;5597.80407685729;5960.433758792908;5989.4609485145675;5997.760089596367;5999.880002399927;6006.219191505076;6685.899711504331;6725.764598239038;6751.93248067513;6752.696128674222;6768.357006084414;1909.8949557774179;1910.2740958435706;1922.1830721943118;1929.2765213045109;1933.8549608779397;1338.7054847933439;1390.7149034447914;1406.6834962133644;1408.295852073963;1423.5871597236892;5588.91616625751;5622.200895713332;5672.376038635747;5688.715564221772;5758.3665796762325;6435.871282574416;6590.275069742324;6613.801585952429;6631.767888123893;6718.462522998148;5420.566354691615;5576.841421684925;5658.660480371191;5671.177679236487;5716.57125715573;3544.3088597723195;3572.8027263232925;3580.3555360034925;3585.731070169748;3586.193106551057;6368.904466433008;6424.74301027963;6466.06242094903;6489.091527186198;6556;6827.2590489425875;6840.452763778985;6840.657967101724;6918.751405793138;6954.65226738661;6456;6515.9574468084875;6527.053577231275;6564.896939412867;6592.79141487607;6648.83377915556;6699.732010719712;6709.563878347892;6756.831079223059;6780.525363224527;6636.966815165893;6677.599344039373;6696.59820410777;6705;6729.831754206184;6297.606909374408;6318;6371.649559274284;6379.3301703320485;6449.6130232186215;5348.1977703343255;5411.2965314508865;5436.483534064258;5450;5471.179323101566;6425.775097871552;6557.901631475627;6576.375244351779;6685.799426017227;6712.328767123248;6263;6446.969204700505;6482.902756458751;6538.967305163444;6635.772382109325;6440.645764482811;6519.641419721961;6521.64130972801;6528.258131584841;6551.886179349617;6207.689615519296;6327.841803954938;6349.555531112777;6426.742930282736;6478.902816457663;6441.04039889292;6451.612903225821;6529.412352888263;6561.40947314744;6608.372204640552;6302.180716506825;6311.905321420274;6364.93635063662;6411.358864113551;6441.710123044568 03:45:09 INFO - PID 3859 | |5;yui.html;888.8044630181358;909.7043460875215;927.8608208768684;928.7678080479884;942.1944237676784;16537.17314134293;17212.05333706647;17262.913685431555;17274.04992725403;17287.654246915055;15443.382264709426;15480.767788483154;15708.685826283467;15732.449364272225;16425.342986280564;935.4480856294784;950.9334346595741;952.5808644196566;957.8946315905245;958.9424634521916;973.7955029443825;973.9269554783419;974.0503009565688;974.0697633759743;975.1321324021626;971.0920289529313;1007.8840933292655;1008.5259927833943;1016.2987538598344;1018.9796204075914;992.8361820299642;998.0668075349571;999.6101520407084;1000.4047591682937;1000.7197984564334;737.2848337112991;739.7595781371076;740.3189066059239;741.6143605325254;744.2631794523382;16239.51281461558;16775;16798.32806687731;17198.226079826312;17307.394241201622;21831.45421364463;22005.33983980483;22045.11819527217;22399.888000560055;22442.102315907345;16686.33254669812;17200.56998575033;17256.913715431343;17302.307907683677;17309.221085051202;3676.8161591920566;3743.6630703236565;3785.034816121899;3787.110029143149;3789.109559253573;98021.50989245079;109647.45176274148;135346;139218.30390848083;139496;17476.300947962194;17667.20497577612;17676.91161544184;17839.197236124404;17855.28578856857;31076;31287.530687039714;31643.525347119812;31829.84085079606;31988;8690.739277821676;8705.303575713928;8716.302695784321;8734.344924130715;8754.387192896436;4221.662267018631;4265.0403659177055;4289.699721019499;4289.978550107292;4348.891277718019;5002.274670172805;5059.949400505948;5113.923291150636;5115.693058416507;5129.538341549204;1012.6556970630021;1038.5689938675516;1039.4875456211194;1054.0408228512017;1058.063613701864;652.8204743695521;662.7580932959435;676.0940339944498;683.111954459201;683.1699485125497;10454.738631534272;10705.090067344363;10787.394125291974;11192;11288.661340159808;647.0682217606632;658.3087757854233;659.9276176213652;665.6139439125295;673.1719984419094;4942.654014218971;5011.728302640159;5135.948640513622;5150.124478838607;5165.14775062118;123168;123318.38340808418;124916;125734.37132814278;129674.35162824126;108160.4591977035;108206;109367;111307;114008.42995784969;89933.55033224923;95085;95276;96762;97527;9165.908340916505;9223.169914707709;9280.350375473652;9338.393004454689;9441.575129119343;42895;43311;44086.33870492009;44899.551004490844;45792.77103614461;55646.16530752123;55830.162547561005;56605.71697141488;56813.715931420076;57340.1398979024;14489.492867749577;14594.708105837612;14604;14739.631509212355;14805.777913331092;16670.58323541921;16710.58223544421;16848.326066957183;16952.745708814626;17036.233369498652;13548.25484598317;13649;13740.93129534346;13846.723065538834;13908;13503.12229705066;13563.932180339036;13571.932140339235;13609.795853062014;13656.590302290948;14290.499832505813;14412.279386030446;14453.566393008226;14535.927320363331;14625.85374146245;10080.64717734905;10168.949155254177;10279.074883260542;10549.314294570828;10654.680359588914;11004.724881878017;11052.392118433241;11081.403891034975;11161.609343672932;11196.776064478829 03:45:09 INFO - PID 3859 | __end_tp_report 03:45:09 INFO - PID 3859 | __start_cc_report 03:45:09 INFO - PID 3859 | _x_x_mozilla_cycle_collect,366 03:45:09 INFO - PID 3859 | __end_cc_report 03:45:09 INFO - PID 3859 | __startTimestamp1505213109077__endTimestamp 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | ------- Summary: start ------- 03:45:09 INFO - PID 3859 | Number of tests: 6 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#0] dojo.html Cycles:165 Average:6170.20 Median:6447.32 stddev:733.44 (11.4%) stddev-sans-first:694.82 03:45:09 INFO - PID 3859 | Values: 3092.8 3098.9 3102.0 3135.6 3148.3 6091.9 6229.3 6288.9 6303.3 6342.2 6158.3 6209.5 6216.9 6221.7 6242.0 5735.3 5748.3 5770.2 5791.0 5863.4 5814.8 5881.4 5888.6 5893.0 5922.8 5802.6 5808.2 5819.6 5891.2 5891.4 5569.1 5707.0 5738.2 5784.9 5835.0 5704.5 5711.8 5740.3 5766.3 5784.9 6111.9 6118.4 6153.8 6184.0 6304.5 6517.4 6569.1 6576.8 6582.7 6588.7 6612.9 6626.5 6645.0 6765.9 6776.3 6225.4 6271.4 6285.5 6289.5 6354.1 6619.0 6904.7 6926.4 6978.2 7001.6 6471.5 6485.1 6555.4 6603.0 6608.4 6690.8 6693.6 6751.6 6755.4 6775.4 6657.4 6696.4 6756.6 6758.3 6764.8 6543.2 6663.9 6676.7 6676.8 6758.7 5257.5 5266.6 5321.7 5324.0 5335.6 4614.9 4668.2 4682.2 4702.9 4708.1 5676.4 5743.7 5796.0 5836.4 5848.9 6565.5 6679.6 6726.8 6758.9 6766.1 5777.9 5789.0 5790.8 5795.1 5795.4 5764.2 5794.6 5813.3 5819.3 5837.6 6527.5 6532.7 6596.6 6602.4 6609.9 6547.5 6691.2 6727.8 6827.7 6833.5 6366.0 6465.3 6532.4 6539.9 6552.0 6600.9 6672.1 6675.9 6684.8 6687.3 6761.7 6780.6 6824.2 6844.7 6856.1 6482.9 6497.6 6499.4 6567.4 6589.9 6377.8 6480.3 6491.9 6571.6 6583.3 6421.8 6460.9 6483.8 6502.0 6522.9 6548.3 6608.6 6660.5 6667.5 6677.2 6187.6 6312.5 6360.1 6404.7 6447.3 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#1] ext.html Cycles:180 Average:37547.79 Median:3525.62 stddev:52850.32 (1499.0%) stddev-sans-first:52926.77 03:45:09 INFO - PID 3859 | Values: 857.3 875.4 881.6 883.3 887.9 38525.2 41782.0 42285.0 42478.0 42564.4 38053.6 38336.0 38446.0 38482.0 38611.4 6857.3 6859.3 6973.0 6991.7 7029.7 6993.7 7076.3 7080.5 7082.0 7083.7 7016.5 7026.9 7037.4 7062.2 7065.4 6963.8 7021.1 7466.4 7666.8 7719.5 7640.4 7707.4 7710.5 7712.0 7717.8 37568.2 37666.6 37748.2 39051.4 39868.8 3480.7 3516.4 3519.7 3522.9 3528.4 32510.3 32589.2 32674.7 32707.3 32760.0 5122.8 5181.6 5201.1 5214.2 5298.9 182796.0 184638.0 187580.0 187651.0 187858.0 41410.4 42087.4 48803.0 49447.5 50192.0 52605.2 52747.2 52907.5 53075.0 53102.0 16263.6 16288.5 16291.8 16351.3 16362.4 13187.1 13356.3 13385.2 13431.7 13555.8 14379.1 14401.8 14512.3 14547.6 14647.9 5746.8 5794.0 5806.6 5881.6 6058.6 1008.0 1014.4 1029.6 1034.5 1048.2 22697.4 23015.9 23124.7 23139.3 23416.6 1106.7 1125.4 1126.3 1140.1 1143.0 12354.3 12373.3 12377.1 12429.9 12482.5 223137.0 224043.0 224539.0 224973.0 226270.0 52763.5 52831.5 53358.0 53507.5 53523.7 1434.9 1465.7 1480.3 1490.7 1503.6 22269.3 22419.8 22600.4 22691.9 22938.8 37172.3 37187.0 37619.0 37694.6 37743.6 196543.0 198955.0 200085.0 201131.0 201185.0 34693.1 35129.6 35818.3 35944.6 36089.6 44257.0 45217.1 45736.0 45828.5 47074.0 33496.7 33833.7 33993.3 34076.7 34274.0 33073.7 33255.3 33344.2 33346.8 33803.2 37866.0 37873.8 38024.2 38048.4 38270.2 32848.3 32849.8 32863.3 32892.0 33173.2 23345.6 23459.5 23717.8 23943.6 24003.6 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#2] jquery.html Cycles:180 Average:35300.33 Median:21972.62 stddev:81541.53 (371.1%) stddev-sans-first:81728.54 03:45:09 INFO - PID 3859 | Values: 551.4 558.9 566.6 569.6 590.8 21796.5 22461.1 22631.7 22692.1 22708.4 23599.4 24063.4 24457.9 25655.5 25806.7 6333.9 6397.1 6418.6 6424.8 6460.5 6095.2 6122.8 6167.9 6171.4 6255.5 6570.6 6571.8 6575.6 6576.7 6583.0 6567.5 6570.9 6571.8 6578.8 6581.2 6571.1 6887.9 6909.7 6961.9 6983.8 31198.5 31452.4 31726.2 31729.8 31741.0 2075.7 2099.6 2102.7 2104.0 2112.8 20292.4 20606.4 20961.8 21097.8 21437.9 2451.4 2487.8 2493.9 2555.6 2560.1 118684.0 122502.4 123569.4 123614.0 137576.0 18775.5 20822.0 21700.2 21978.7 22156.0 43479.6 43773.1 43810.0 43886.8 43942.0 11205.0 11329.8 11354.4 11419.4 11446.9 9304.2 9363.3 9399.7 9494.3 9556.4 10953.5 11074.8 11124.6 11341.5 11560.4 3730.2 4058.7 4117.3 4328.2 4404.0 954.1 958.6 966.4 972.9 983.9 19404.5 19539.5 19641.2 19826.0 20279.0 1029.4 1032.3 1037.2 1038.7 1039.4 10794.4 11124.8 11156.9 11252.7 11427.4 477458.0 488217.0 489655.0 490458.5 492000.1 112380.0 113748.0 114612.0 114778.4 116169.4 1126.3 1135.0 1160.2 1167.2 1170.8 17437.8 17675.1 17808.5 17971.7 18132.5 52402.5 53867.2 54925.5 55822.2 55904.0 66187.0 67055.3 67573.3 67954.0 69030.0 19736.6 19841.0 20034.6 20285.5 20303.3 21953.2 21966.6 22355.7 22364.8 22377.7 16942.0 17116.1 17124.1 17428.3 18421.3 15979.8 16017.9 16246.4 16471.6 17052.7 17223.2 17234.1 18099.7 18586.7 18640.8 19541.3 19631.5 19660.7 19691.0 19807.9 17393.8 17652.4 17672.4 17923.7 18094.9 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#3] mootools.html Cycles:180 Average:9255.04 Median:14743.33 stddev:6685.71 (45.3%) stddev-sans-first:6677.93 03:45:09 INFO - PID 3859 | Values: 1326.8 1387.4 1395.9 1416.8 1428.4 14582.3 15136.0 15214.7 15235.9 15318.7 15068.3 15070.9 15086.4 15185.1 15207.9 2743.9 2778.1 2817.4 2817.7 2830.6 2681.5 2691.0 2706.7 2707.3 2709.8 2548.5 2551.6 2665.1 2857.2 2865.1 2793.3 2820.0 2821.2 2823.5 2830.6 2632.7 2671.7 2677.9 2683.2 2809.6 14894.3 15045.6 15203.7 15227.2 15228.0 7950.9 8197.4 8210.1 8252.9 8257.4 5131.0 5304.4 5400.2 5419.3 5457.3 1867.1 1944.3 1972.8 1992.8 2006.7 26446.5 26544.3 26567.9 26571.1 26805.2 6629.8 6762.9 6966.2 6998.8 7021.1 16942.6 16956.8 17083.1 17182.1 17187.2 7844.6 8018.6 8019.7 8024.0 8038.1 7299.2 7363.7 7398.8 7428.3 7480.3 5152.5 5338.1 5349.1 5378.7 5549.1 1543.3 1549.6 1555.2 1558.9 1566.8 859.4 864.4 873.2 893.0 895.7 7261.0 7303.7 7323.0 7343.4 7379.0 706.5 728.1 737.6 742.7 747.5 4463.8 4518.5 4673.6 4939.7 5005.4 20525.2 21191.6 21651.8 22343.6 22363.7 21084.3 21653.5 21736.6 21932.3 21937.9 10793.7 11458.0 11478.3 11503.9 11532.4 8118.6 8150.6 8153.6 8163.7 8195.3 17937.3 18570.4 18852.8 18996.0 19011.2 17796.6 19030.5 19456.7 19651.7 20210.2 10907.8 10948.8 11007.9 11028.1 11028.5 13304.3 13464.9 13475.7 13494.9 13559.9 11092.1 11450.3 11485.0 11517.7 11665.7 10493.2 10520.4 10758.2 10792.4 10904.6 9234.5 9382.5 9384.7 9452.0 9455.1 7061.6 7116.3 7239.6 7251.2 7293.5 6826.5 6936.1 6944.4 6999.3 7006.6 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#4] prototype.html Cycles:180 Average:5611.92 Median:6225.05 stddev:1497.62 (24.1%) stddev-sans-first:1451.83 03:45:09 INFO - PID 3859 | Values: 499.6 506.9 514.9 521.7 524.3 6312.0 6380.6 6385.0 6418.2 6421.9 6183.9 6307.0 6343.8 6344.3 6375.9 5218.6 5219.1 5225.8 5227.9 5235.2 5136.9 5171.5 5194.6 5213.8 5236.1 5015.4 5108.5 5133.4 5144.8 5233.8 5162.4 5175.7 5197.8 5247.2 5260.7 4843.4 4844.3 4849.5 4850.8 4857.7 5957.7 6114.7 6151.9 6192.4 6242.4 5941.7 5975.9 6012.3 6015.2 6033.4 6591.3 6610.2 6638.4 6654.3 6749.3 5065.6 5216.2 5219.7 5256.9 5271.6 6782.7 6835.4 6840.2 6892.7 6909.9 5409.2 5438.2 5469.4 5482.8 5509.5 5526.2 5526.9 5527.0 5575.3 5597.8 5960.4 5989.5 5997.8 5999.9 6006.2 6685.9 6725.8 6751.9 6752.7 6768.4 1909.9 1910.3 1922.2 1929.3 1933.9 1338.7 1390.7 1406.7 1408.3 1423.6 5588.9 5622.2 5672.4 5688.7 5758.4 6435.9 6590.3 6613.8 6631.8 6718.5 5420.6 5576.8 5658.7 5671.2 5716.6 3544.3 3572.8 3580.4 3585.7 3586.2 6368.9 6424.7 6466.1 6489.1 6556.0 6827.3 6840.5 6840.7 6918.8 6954.7 6456.0 6516.0 6527.1 6564.9 6592.8 6648.8 6699.7 6709.6 6756.8 6780.5 6637.0 6677.6 6696.6 6705.0 6729.8 6297.6 6318.0 6371.6 6379.3 6449.6 5348.2 5411.3 5436.5 5450.0 5471.2 6425.8 6557.9 6576.4 6685.8 6712.3 6263.0 6447.0 6482.9 6539.0 6635.8 6440.6 6519.6 6521.6 6528.3 6551.9 6207.7 6327.8 6349.6 6426.7 6478.9 6441.0 6451.6 6529.4 6561.4 6608.4 6302.2 6311.9 6364.9 6411.4 6441.7 03:45:09 INFO - PID 3859 | 03:45:09 INFO - PID 3859 | [#5] yui.html Cycles:180 Average:23432.24 Median:21918.40 stddev:34505.73 (157.4%) stddev-sans-first:34561.01 03:45:09 INFO - PID 3859 | Values: 888.8 909.7 927.9 928.8 942.2 16537.2 17212.1 17262.9 17274.0 17287.7 15443.4 15480.8 15708.7 15732.4 16425.3 935.4 950.9 952.6 957.9 958.9 973.8 973.9 974.1 974.1 975.1 971.1 1007.9 1008.5 1016.3 1019.0 992.8 998.1 999.6 1000.4 1000.7 737.3 739.8 740.3 741.6 744.3 16239.5 16775.0 16798.3 17198.2 17307.4 21831.5 22005.3 22045.1 22399.9 22442.1 16686.3 17200.6 17256.9 17302.3 17309.2 3676.8 3743.7 3785.0 3787.1 3789.1 98021.5 109647.5 135346.0 139218.3 139496.0 17476.3 17667.2 17676.9 17839.2 17855.3 31076.0 31287.5 31643.5 31829.8 31988.0 8690.7 8705.3 8716.3 8734.3 8754.4 4221.7 4265.0 4289.7 4290.0 4348.9 5002.3 5059.9 5113.9 5115.7 5129.5 1012.7 1038.6 1039.5 1054.0 1058.1 652.8 662.8 676.1 683.1 683.2 10454.7 10705.1 10787.4 11192.0 11288.7 647.1 658.3 659.9 665.6 673.2 4942.7 5011.7 5135.9 5150.1 5165.1 123168.0 123318.4 124916.0 125734.4 129674.4 108160.5 108206.0 109367.0 111307.0 114008.4 89933.6 95085.0 95276.0 96762.0 97527.0 9165.9 9223.2 9280.4 9338.4 9441.6 42895.0 43311.0 44086.3 44899.6 45792.8 55646.2 55830.2 56605.7 56813.7 57340.1 14489.5 14594.7 14604.0 14739.6 14805.8 16670.6 16710.6 16848.3 16952.7 17036.2 13548.3 13649.0 13740.9 13846.7 13908.0 13503.1 13563.9 13571.9 13609.8 13656.6 14290.5 14412.3 14453.6 14535.9 14625.9 10080.6 10168.9 10279.1 10549.3 10654.7 11004.7 11052.4 11081.4 11161.6 11196.8 03:45:09 INFO - PID 3859 | -------- Summary: end -------- 03:45:09 INFO - PID 3859 | 03:45:10 INFO - TEST-INFO | 3859: exit 0 03:45:10 INFO - TEST-OK | dromaeo_css | took 1121798ms 03:45:10 INFO - TEST-START | kraken 03:45:10 INFO - Initialising browser for kraken test... 03:45:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36268/getInfo.html -profile /tmp/tmpt9W4B_/profile 03:45:10 INFO - TEST-INFO | started process 4247 (/builds/slave/test/build/application/firefox/firefox http://localhost:36268/getInfo.html) 03:45:17 INFO - TEST-INFO | 4247: exit 0 03:45:17 INFO - Browser initialized. 03:45:17 INFO - Running cycle 1/1 for kraken test... 03:45:17 INFO - Using env: {'DISPLAY': ':0', 03:45:17 INFO - 'HOME': '/home/cltbld', 03:45:17 INFO - 'JSGC_DISABLE_POISONING': '1', 03:45:17 INFO - 'LANG': 'en_US.UTF-8', 03:45:17 INFO - 'LANGUAGE': 'en_US:en', 03:45:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:45:17 INFO - 'LOGNAME': 'cltbld', 03:45:17 INFO - 'MAIL': '/var/mail/cltbld', 03:45:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:17 INFO - 'MOZ_ACCELERATED': '1', 03:45:17 INFO - 'MOZ_CRASHREPORTER': '1', 03:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:45:17 INFO - 'MOZ_NO_REMOTE': '1', 03:45:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:17 INFO - 'MOZ_WEBRENDER': '1', 03:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:17 INFO - 'NO_EM_RESTART': '1', 03:45:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:17 INFO - 'PWD': '/builds/slave/test', 03:45:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:17 INFO - 'RUST_BACKTRACE': 'full', 03:45:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:45:17 INFO - 'SHELL': '/bin/bash', 03:45:17 INFO - 'SHLVL': '1', 03:45:17 INFO - 'TERM': 'linux', 03:45:17 INFO - 'TMOUT': '86400', 03:45:17 INFO - 'USER': 'cltbld', 03:45:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194', 03:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:17 INFO - '_': '/tools/buildbot/bin/python'} 03:45:17 INFO - TEST-INFO | started process 4460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt9W4B_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:18 INFO - PID 4460 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:45:18 INFO - PID 4460 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:45:18 INFO - PID 4460 | 03:45:18 INFO - PID 4460 | (/builds/slave/test/build/application/firefox/firefox:4521): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:18 INFO - PID 4460 | 03:45:29 INFO - PID 4460 | RSS: Main: 211443712 03:45:29 INFO - PID 4460 | 03:45:32 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:33 INFO - PID 4460 | RSS: Main: 217309184 03:45:33 INFO - PID 4460 | 03:45:35 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-dft) 03:45:36 INFO - PID 4460 | RSS: Main: 216010752 03:45:36 INFO - PID 4460 | 03:45:39 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-fft) 03:45:40 INFO - PID 4460 | RSS: Main: 213504000 03:45:40 INFO - PID 4460 | 03:45:42 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36268/tests/kraken/driver.html?testName=audio-oscillator) 03:45:42 INFO - PID 4460 | RSS: Main: 213762048 03:45:42 INFO - PID 4460 | 03:45:44 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:45 INFO - PID 4460 | RSS: Main: 213856256 03:45:45 INFO - PID 4460 | 03:45:48 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:49 INFO - PID 4460 | RSS: Main: 216027136 03:45:49 INFO - PID 4460 | 03:45:53 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36268/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:53 INFO - PID 4460 | RSS: Main: 215375872 03:45:53 INFO - PID 4460 | 03:45:56 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36268/tests/kraken/driver.html?testName=json-parse-financial) 03:45:57 INFO - PID 4460 | RSS: Main: 216150016 03:45:57 INFO - PID 4460 | 03:45:59 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:59 INFO - PID 4460 | RSS: Main: 216489984 03:46:00 INFO - PID 4460 | 03:46:01 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:02 INFO - PID 4460 | RSS: Main: 217133056 03:46:02 INFO - PID 4460 | 03:46:04 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:05 INFO - PID 4460 | RSS: Main: 217636864 03:46:05 INFO - PID 4460 | 03:46:10 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:10 INFO - PID 4460 | RSS: Main: 216518656 03:46:10 INFO - PID 4460 | 03:46:13 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:14 INFO - PID 4460 | RSS: Main: 217206784 03:46:14 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | Cycle 1(1): loaded http://localhost:36268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36268/tests/kraken/driver.html?testName=ai-astar) 03:46:16 INFO - PID 4460 | RSS: Main: 220499968 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | __start_tp_report 03:46:16 INFO - PID 4460 | _x_x_mozilla_page_load 03:46:16 INFO - PID 4460 | _x_x_mozilla_page_load_details 03:46:16 INFO - PID 4460 | |i|pagename|runs| 03:46:16 INFO - PID 4460 | |0;ai-astar;108;115;107;116;119;112;110;117;110;109 03:46:16 INFO - PID 4460 | |1;audio-beat-detection;121;126;117;123;118;118;123;144;119;119 03:46:16 INFO - PID 4460 | |2;audio-dft;173;163;163;163;170;164;169;163;162;164 03:46:16 INFO - PID 4460 | |3;audio-fft;78;78;80;73;73;77;84;83;75;84 03:46:16 INFO - PID 4460 | |4;audio-oscillator;80;87;81;80;96;82;87;88;83;85 03:46:16 INFO - PID 4460 | |5;imaging-gaussian-blur;115;114;110;114;116;118;117;114;122;112 03:46:16 INFO - PID 4460 | |6;imaging-darkroom;148;152;149;149;149;150;149;148;148;149 03:46:16 INFO - PID 4460 | |7;imaging-desaturate;101;98;95;103;94;97;95;96;98;95 03:46:16 INFO - PID 4460 | |8;json-parse-financial;58;55;51;52;56;54;54;54;54;54 03:46:16 INFO - PID 4460 | |9;json-stringify-tinderbox;38;39;39;40;39;47;47;48;45;47 03:46:16 INFO - PID 4460 | |10;stanford-crypto-aes;76;77;76;74;79;80;78;73;72;75 03:46:16 INFO - PID 4460 | |11;stanford-crypto-ccm;115;115;112;112;117;118;112;124;113;112 03:46:16 INFO - PID 4460 | |12;stanford-crypto-pbkdf2;176;179;179;172;185;175;173;178;176;177 03:46:16 INFO - PID 4460 | |13;stanford-crypto-sha256-iterative;66;68;67;67;68;68;67;66;66;63 03:46:16 INFO - PID 4460 | __end_tp_report 03:46:16 INFO - PID 4460 | __start_cc_report 03:46:16 INFO - PID 4460 | _x_x_mozilla_cycle_collect,954 03:46:16 INFO - PID 4460 | __end_cc_report 03:46:16 INFO - PID 4460 | __startTimestamp1505213176476__endTimestamp 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | ------- Summary: start ------- 03:46:16 INFO - PID 4460 | Number of tests: 14 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:4.16 (3.7%) stddev-sans-first:4.12 03:46:16 INFO - PID 4460 | Values: 108.0 115.0 107.0 116.0 119.0 112.0 110.0 117.0 110.0 109.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:122.00 stddev:7.97 (6.5%) stddev-sans-first:8.43 03:46:16 INFO - PID 4460 | Values: 121.0 126.0 117.0 123.0 118.0 118.0 123.0 144.0 119.0 119.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:3.81 (2.3%) stddev-sans-first:2.88 03:46:16 INFO - PID 4460 | Values: 173.0 163.0 163.0 163.0 170.0 164.0 169.0 163.0 162.0 164.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#3] audio-fft Cycles:10 Average:78.50 Median:79.00 stddev:4.20 (5.3%) stddev-sans-first:4.45 03:46:16 INFO - PID 4460 | Values: 78.0 78.0 80.0 73.0 73.0 77.0 84.0 83.0 75.0 84.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:86.00 stddev:4.91 (5.7%) stddev-sans-first:4.88 03:46:16 INFO - PID 4460 | Values: 80.0 87.0 81.0 80.0 96.0 82.0 87.0 88.0 83.0 85.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.50 stddev:3.33 (2.9%) stddev-sans-first:3.53 03:46:16 INFO - PID 4460 | Values: 115.0 114.0 110.0 114.0 116.0 118.0 117.0 114.0 122.0 112.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 03:46:16 INFO - PID 4460 | Values: 148.0 152.0 149.0 149.0 149.0 150.0 149.0 148.0 148.0 149.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:95.50 stddev:2.90 (3.0%) stddev-sans-first:2.73 03:46:16 INFO - PID 4460 | Values: 101.0 98.0 95.0 103.0 94.0 97.0 95.0 96.0 98.0 95.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.93 (3.6%) stddev-sans-first:1.48 03:46:16 INFO - PID 4460 | Values: 58.0 55.0 51.0 52.0 56.0 54.0 54.0 54.0 54.0 54.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#9] json-stringify-tinderbox Cycles:10 Average:42.90 Median:46.00 stddev:4.20 (9.1%) stddev-sans-first:4.07 03:46:16 INFO - PID 4460 | Values: 38.0 39.0 39.0 40.0 39.0 47.0 47.0 48.0 45.0 47.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.50 stddev:2.58 (3.4%) stddev-sans-first:2.74 03:46:16 INFO - PID 4460 | Values: 76.0 77.0 76.0 74.0 79.0 80.0 78.0 73.0 72.0 75.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.00 stddev:3.86 (3.4%) stddev-sans-first:4.09 03:46:16 INFO - PID 4460 | Values: 115.0 115.0 112.0 112.0 117.0 118.0 112.0 124.0 113.0 112.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.50 stddev:3.65 (2.1%) stddev-sans-first:3.86 03:46:16 INFO - PID 4460 | Values: 176.0 179.0 179.0 172.0 185.0 175.0 173.0 178.0 176.0 177.0 03:46:16 INFO - PID 4460 | 03:46:16 INFO - PID 4460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.58 03:46:16 INFO - PID 4460 | Values: 66.0 68.0 67.0 67.0 68.0 68.0 67.0 66.0 66.0 63.0 03:46:16 INFO - PID 4460 | -------- Summary: end -------- 03:46:16 INFO - PID 4460 | 03:46:17 INFO - PID 4460 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:46:17 INFO - TEST-INFO | 4460: exit 0 03:46:17 INFO - TEST-OK | kraken | took 67458ms 03:46:17 INFO - SUITE-END | took 1189s 03:46:18 INFO - Completed test suite (00:19:49) 03:46:18 INFO - javascript benchmark 03:46:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.692705599758, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.845357732113, 3098.876044958202, 3102.0, 3135.592372991512, 3148.291634382263, 6091.878162436759, 6229.252489701236, 6288.937110628893, 6303.338149494306, 6342.175517182772, 6158.322584515699, 6209.503239740821, 6216.937830621692, 6221.657808820513, 6242.0, 5735.254416925804, 5748.281464816898, 5770.2210201622875, 5791.015527360359, 5863.384344643815, 5814.8255552333285, 5881.441263080001, 5888.617239879415, 5892.968730472172, 5922.822315330525, 5802.564807639444, 5808.215890854723, 5819.563532735041, 5891.175235467038, 5891.440313170264, 5569.10894256921, 5707.0, 5738.225339579145, 5784.913226301609, 5834.970825145847, 5704.4865962063195, 5711.8000869969355, 5740.311162660508, 5766.308043034863, 5784.942150578482, 6111.908321375183, 6118.449339559416, 6153.784617538409, 6184.041473571604, 6304.495640348807, 6517.4134327910715, 6569.113169722074, 6576.80269591913, 6582.736690532373, 6588.670566471706, 6612.867742645169, 6626.536142470029, 6645.0, 6765.932340676629, 6776.288489708559, 6225.408586184305, 6271.4042165994615, 6285.528585356116, 6289.528285378569, 6354.142190804275, 6618.96690516554, 6904.689288982008, 6926.411255043277, 6978.197507286625, 7001.579905205704, 6471.5146364022885, 6485.059666348353, 6555.4427873631275, 6603.042558828943, 6608.438282745924, 6690.799276021728, 6693.631850248185, 6751.594904305757, 6755.392014718699, 6775.3902148805855, 6657.40083392497, 6696.363845434676, 6756.560823546453, 6758.324167583202, 6764.797056088325, 6543.214814222324, 6663.866722665616, 6676.699548520328, 6676.83307917306, 6758.695858686371, 5257.474252574789, 5266.631335806457, 5321.6540924839765, 5323.973380133152, 5335.62650614461, 4614.907701846011, 4668.15973124834, 4682.227432473672, 4702.905941881143, 4708.105459962596, 5676.4323567642905, 5743.655380677173, 5795.971020144872, 5836.445537673914, 5848.853778655568, 6565.507586930999, 6679.599224046573, 6726.764563240263, 6758.93241067583, 6766.052752614638, 5777.8555536111935, 5789.0, 5790.768369265266, 5795.1017592273265, 5795.420457954255, 5764.193012978187, 5794.623349482355, 5813.331466881278, 5819.301683797887, 5837.591368604242, 6527.54307198501, 6532.6733663316645, 6596.571222870498, 6602.372774586406, 6609.86780264392, 6547.541672083099, 6691.1636045494315, 6727.798166055026, 6827.692753825991, 6833.453323734089, 6366.045093236052, 6465.2564955030775, 6532.379423954717, 6539.901901471387, 6552.049952756728, 6600.900986485302, 6672.065910772592, 6675.866482670416, 6684.799456016327, 6687.264400915993, 6761.729530818712, 6780.559263647847, 6824.2152152503095, 6844.691988860613, 6856.108705868205, 6482.870342593216, 6497.610143391223, 6499.38255865692, 6567.441767449629, 6589.901151482636, 6377.7767778127545, 6480.25477070143, 6491.935080649133, 6571.638559879252, 6583.3087525811015, 6421.775237866652, 6460.903086453801, 6483.773067942788, 6501.9674901625185, 6522.902156467562, 6548.3124271952665, 6608.603483790988, 6660.467162626881, 6667.533272670867, 6677.198736151693, 6187.566870319034, 6312.4634406076, 6360.077788720702, 6404.71178796946, 6447.323031081856], "value": 6114.2611811401075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.3484152044446, 875.4047247871449, 881.6253092435713, 883.2713011765295, 887.862381330894, 38525.22949541007, 41782.0, 42285.0, 42478.0, 42564.36153457701, 38053.61946380536, 38336.0, 38446.0, 38482.0, 38611.420828687595, 6857.348551887588, 6859.279775623562, 6972.965135174317, 6991.685374158163, 7029.718811247544, 6993.6503174841055, 7076.292370762908, 7080.539764915264, 7082.043924070262, 7083.716651333966, 7016.508844380895, 7026.910828821541, 7037.437005039585, 7062.223155452896, 7065.434765218796, 6963.79108626742, 7021.122359705037, 7466.440016998747, 7666.808329791744, 7719.498232614918, 7640.426967977424, 7707.421943354271, 7710.537367757953, 7712.035995500562, 7717.845643087163, 37568.24863502742, 37666.62333376686, 37748.24503509942, 39051.41422878659, 39868.80065599683, 3480.738944579167, 3516.384632689269, 3519.7184225261917, 3522.8766993155373, 3528.3648943190215, 32510.349793004243, 32589.18527036843, 32674.6732532674, 32707.345853083043, 32760.0, 5122.846314610568, 5181.611379146579, 5201.08980928336, 5214.217867319894, 5298.947010529884, 182796.0, 184638.0, 187580.0, 187650.99999999863, 187858.0, 41410.37884431736, 42087.36868946968, 48803.0, 49447.50552494501, 50192.0, 52605.2109218362, 52747.20879186815, 52907.470925290254, 53075.0, 53102.0, 16263.59341016484, 16288.511344659679, 16291.837081629032, 16351.26419311134, 16362.427315043917, 13187.076904616584, 13356.265405402795, 13385.19688818674, 13431.731365372832, 13555.796663050061, 14379.137251764927, 14401.78397324041, 14512.346944387527, 14547.563573092824, 14647.92676036613, 5746.827595172152, 5793.971030144822, 5806.593538452352, 5881.558883083786, 6058.636481811105, 1007.9798404031878, 1014.4065721552827, 1029.6447725534679, 1034.4517405774952, 1048.219076787798, 22697.432564186027, 23015.88492057529, 23124.65313020306, 23139.3058208254, 23416.64875026876, 1106.7233191702076, 1125.4204084896285, 1126.307320997597, 1140.1448913315014, 1142.9998751092794, 12354.25874447536, 12373.257604543576, 12377.071719621064, 12429.937850310691, 12482.50069997208, 223137.0, 224043.0, 224539.0, 224973.0, 226270.0, 52763.472365276626, 52831.47168528265, 53358.0, 53507.46492535103, 53523.732381337846, 1434.9210793406255, 1465.6922046370169, 1480.2746654139394, 1490.6720521485256, 1503.646643038885, 22269.331920042423, 22419.77580224177, 22600.434989124744, 22691.886540567193, 22938.770612293665, 37172.256554869295, 37187.0, 37619.0, 37694.62305376911, 37743.62256377401, 196543.0, 198955.0, 200085.0, 201131.0, 201185.0, 34693.13267168341, 35129.64870351366, 35818.28363432769, 35944.64055359518, 36089.639103609676, 44257.0, 45217.09565808731, 45736.0, 45828.541714582425, 47074.0, 33496.66503335033, 33833.66166338305, 33993.320133596695, 34076.65923340735, 34274.0, 33073.669263307056, 33255.334893301515, 33344.1663958403, 33346.83326583351, 33803.15492112717, 37866.0, 37873.81063094667, 38024.23951520899, 38048.42927356037, 38270.23459530738, 32848.34303313873, 32849.83575082205, 32863.342733144724, 32892.0, 33173.17067073342, 23345.608414917067, 23459.530809384058, 23717.762822371555, 23943.640845387683, 24003.639945400482], "value": 17175.93353964737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4099913092992, 558.8938101760665, 566.56091529065, 569.6382796923953, 590.7725525672618, 21796.45508862279, 22461.101555937785, 22631.66052509214, 22692.09231630735, 22708.432289192777, 23599.41001474964, 24063.39841503963, 24457.87771061142, 25655.48689026223, 25806.74193258067, 6333.873322533546, 6397.072424498445, 6418.550701450877, 6424.775132870351, 6460.547761656686, 6095.207623009025, 6122.816315510542, 6167.9074813877605, 6171.382861713815, 6255.530835187356, 6570.63861487618, 6571.835704107411, 6575.638339891304, 6576.704048317813, 6582.9670851645915, 6567.474602031826, 6570.8685826283445, 6571.80284591463, 6578.80263592093, 6581.177352830896, 6571.145751052381, 6887.931120688779, 6909.689063992132, 6961.895571566431, 6983.790486285419, 31198.532022019688, 31452.37095258082, 31726.206844828834, 31729.84135079333, 31741.0, 2075.7197778299887, 2099.643060679688, 2102.6845973104005, 2103.978960210394, 2112.7992840680113, 20292.391228263175, 20606.381808545768, 20961.790382096136, 21097.789022109737, 21437.892810536003, 2451.374899400659, 2487.8182863140046, 2493.9002439902383, 2555.5911054231233, 2560.0527804712187, 118684.0, 122502.38748806289, 123569.38215308955, 123614.0, 137576.0, 18775.530611734543, 20822.0, 21700.240491582717, 21978.670319945213, 22155.999999999676, 43479.56520434818, 43773.12453750907, 43810.0, 43886.78056609697, 43942.0, 11205.0, 11329.773404531863, 11354.432278386048, 11419.429028548706, 11446.94276528612, 9304.16262536375, 9363.25129700711, 9399.671011514563, 9494.287928405398, 9556.423190173544, 10953.507092180871, 11074.833877491845, 11124.555017799197, 11341.489632966537, 11560.421978901022, 3730.1607138393642, 4058.6753059755147, 4117.279476091672, 4328.242557552416, 4403.9779801100785, 954.1365064616533, 958.6261358070219, 966.429806414219, 972.863799068131, 983.9016098390103, 19404.499492670115, 19539.511512212022, 19641.214351425784, 19826.0, 20279.0, 1029.4183786160795, 1032.2825636182781, 1037.232447988483, 1038.6676263595728, 1039.3867618105355, 10794.352338859693, 11124.777504449865, 11156.944215278872, 11252.718682033015, 11427.428628568538, 477458.0, 488217.0, 489655.0, 490458.5477072592, 492000.13997130503, 112380.0, 113748.0, 114612.0, 114778.42610787059, 116169.41915290538, 1126.318577260762, 1134.9773004539863, 1160.1936654025371, 1167.229628445222, 1170.777552265067, 17437.82562174362, 17675.116244187997, 17808.46574602764, 17971.73042404391, 18132.456026319232, 52402.47597524129, 53867.191992120934, 54925.45074549203, 55822.162667559205, 55904.0, 66187.0, 67055.32944670686, 67573.32426675867, 67954.0, 69030.0, 19736.605267894847, 19841.0, 20034.59930801405, 20285.49286267855, 20303.28938487146, 21953.23163689327, 21966.560668786853, 22355.664665030363, 22364.77635223627, 22377.66433503466, 16942.0, 17116.0586167757, 17124.14379281056, 17428.302867885144, 18421.26314947387, 15979.840201598301, 16017.919910400373, 16246.350145994027, 16471.621560926455, 17052.65894682124, 17223.22495487681, 17234.138293085045, 18099.72850407271, 18586.721199182295, 18640.81359186391, 19541.31605393861, 19631.509212269808, 19660.705089423955, 19691.0, 19807.900960495106, 17393.782435229412, 17652.382166624106, 17672.381466648607, 17923.73114403259, 18094.909525452287], "value": 12698.460989515972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.7744483437814, 1387.3618135657598, 1395.8953078519114, 1416.8228971378578, 1428.4357678716908, 14582.343794529244, 15136.0, 15214.695706085886, 15235.923820380896, 15318.693626127499, 15068.32192551335, 15070.924645376757, 15086.396544138248, 15185.0888946663, 15207.92396038021, 2743.890244390232, 2778.097118436506, 2817.4365126974585, 2817.7464028237455, 2830.5895645131445, 2681.4637072585465, 2691.0, 2706.715794841533, 2707.3367025078883, 2709.810313278071, 2548.4775620997743, 2551.591745320749, 2665.1471529110595, 2857.214266076835, 2865.1404578626434, 2793.3016745813547, 2820.0, 2821.195959151632, 2823.463541927048, 2830.5754136879427, 2632.7498887605648, 2671.6793984721958, 2677.866106694677, 2683.195041487546, 2809.592609071673, 14894.255287235703, 15045.623859403493, 15203.695926081416, 15227.238638068053, 15228.0, 7950.880736788953, 8197.426180167391, 8210.137935516805, 8252.917470825336, 8257.38069644773, 5131.0, 5304.416514183436, 5400.1899715043055, 5419.268398766156, 5457.263269458612, 1867.1224524473475, 1944.3389247655723, 1972.7829938706732, 1992.810682985114, 2006.6889632107047, 26446.471070578675, 26544.336391590172, 26567.86716066446, 26571.070012549662, 26805.195844124708, 6629.834254143685, 6762.898556521656, 6966.164060312795, 6998.75504357345, 7021.052157958712, 16942.57643558921, 16956.830431695773, 17083.145842708065, 17182.054986975836, 17187.226574803914, 7844.646990885424, 8018.639161237758, 8019.719309824245, 8024.037115546172, 8038.115807261197, 7299.23358047408, 7363.742269020666, 7398.779201431704, 7428.2571742825285, 7480.289372509603, 5152.4847515248175, 5338.145896656516, 5349.144136938071, 5378.677279363251, 5549.084401073858, 1543.3440787665422, 1549.5661214859858, 1555.1524419191567, 1558.9298481568358, 1566.7728179414148, 859.3812455032366, 864.3949235535025, 873.1835733588988, 892.9776755581032, 895.6909866096187, 7261.0, 7303.707851685979, 7323.048003759477, 7343.412526997828, 7379.0, 706.4560288577767, 728.1153398620701, 737.5832654550162, 742.7103429662436, 747.5253214209016, 4463.839900936687, 4518.502964673883, 4673.556012178838, 4939.678920870132, 5005.399352077701, 20525.17899284012, 21191.576168476546, 21651.783482164978, 22343.55312893733, 22363.66454503184, 21084.262050828453, 21653.458663533223, 21736.565268694852, 21932.342029739135, 21937.890310548344, 10793.730156745987, 11458.0, 11478.253913495597, 11503.884961150281, 11532.365719885487, 8118.59407029658, 8150.573649611413, 8153.55155466455, 8163.7142700005215, 8195.262426381654, 17937.282508699507, 18570.350037748613, 18852.811471885107, 18996.0, 19011.239550417828, 17796.55508612295, 19030.524236894187, 19456.708149378053, 19651.70522442193, 20210.19159233673, 10907.836382454429, 10948.835767463335, 11007.944960275147, 11028.117750579773, 11028.503717332578, 13304.268265245504, 13464.865351346361, 13475.663108422368, 13494.93252533731, 13559.864401356255, 11092.11263098934, 11450.255733377304, 11485.0, 11517.712057198638, 11665.650030499099, 10493.160547156362, 10520.421376824348, 10758.193135515025, 10792.352458852494, 10904.618338358438, 9234.538273086184, 9382.530873456437, 9384.67153649619, 9452.0, 9455.14903658674, 7061.646917653994, 7116.323949224816, 7239.601821899846, 7251.20236773965, 7293.52592081513, 6826.453883689393, 6936.132983377078, 6944.375006249462, 6999.30006999296, 7006.614636195059], "value": 6580.351407285634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5902182394598, 506.860613331334, 514.8532668189566, 521.6504941689068, 524.2686452398904, 6311.968440157799, 6380.553361264713, 6385.0, 6418.19772528434, 6421.871562568752, 6183.938160618403, 6307.0, 6343.841403964903, 6344.3338449462835, 6375.864085531352, 5218.608604354669, 5219.086659834533, 5225.843224703265, 5227.921581176285, 5235.214717792323, 5136.8715782105555, 5171.50870667286, 5194.558462530689, 5213.791448342062, 5236.136037553799, 5015.423226328964, 5108.471306703187, 5133.409657889334, 5144.819931302405, 5233.790648374061, 5162.380514338303, 5175.715335656538, 5197.752539390557, 5247.23915032322, 5260.658057226268, 4843.4187897452175, 4844.346013288232, 4849.515048495157, 4850.75746212688, 4857.6599638025355, 5957.667887240895, 6114.694265286718, 6151.907721384183, 6192.411720886508, 6242.406971337716, 5941.70291485424, 5975.880482390371, 6012.3085845127935, 6015.218021657157, 6033.366496517846, 6591.274959754423, 6610.239822420435, 6638.402543771083, 6654.301298363651, 6749.3250674932115, 5065.6200784941275, 5216.243644671501, 5219.660722053054, 5256.894862102775, 5271.630985830993, 6782.660866956682, 6835.418989385908, 6840.247572766992, 6892.724291028403, 6909.896351554731, 5409.161579955114, 5438.211459338374, 5469.371022332403, 5482.753276102585, 5509.5041446270025, 5526.171074338881, 5526.944730552724, 5526.972365138148, 5575.330960284792, 5597.80407685729, 5960.433758792908, 5989.4609485145675, 5997.760089596367, 5999.880002399927, 6006.219191505076, 6685.899711504331, 6725.764598239038, 6751.93248067513, 6752.696128674222, 6768.357006084414, 1909.8949557774179, 1910.2740958435706, 1922.1830721943118, 1929.2765213045109, 1933.8549608779397, 1338.7054847933439, 1390.7149034447914, 1406.6834962133644, 1408.295852073963, 1423.5871597236892, 5588.91616625751, 5622.200895713332, 5672.376038635747, 5688.715564221772, 5758.3665796762325, 6435.871282574416, 6590.275069742324, 6613.801585952429, 6631.767888123893, 6718.462522998148, 5420.566354691615, 5576.841421684925, 5658.660480371191, 5671.177679236487, 5716.57125715573, 3544.3088597723195, 3572.8027263232925, 3580.3555360034925, 3585.731070169748, 3586.193106551057, 6368.904466433008, 6424.74301027963, 6466.06242094903, 6489.091527186198, 6556.0, 6827.2590489425875, 6840.452763778985, 6840.657967101724, 6918.751405793138, 6954.65226738661, 6456.0, 6515.9574468084875, 6527.053577231275, 6564.896939412867, 6592.79141487607, 6648.83377915556, 6699.732010719712, 6709.563878347892, 6756.831079223059, 6780.525363224527, 6636.966815165893, 6677.599344039373, 6696.59820410777, 6705.0, 6729.831754206184, 6297.606909374408, 6318.0, 6371.649559274284, 6379.3301703320485, 6449.6130232186215, 5348.1977703343255, 5411.2965314508865, 5436.483534064258, 5450.0, 5471.179323101566, 6425.775097871552, 6557.901631475627, 6576.375244351779, 6685.799426017227, 6712.328767123248, 6263.0, 6446.969204700505, 6482.902756458751, 6538.967305163444, 6635.772382109325, 6440.645764482811, 6519.641419721961, 6521.64130972801, 6528.258131584841, 6551.886179349617, 6207.689615519296, 6327.841803954938, 6349.555531112777, 6426.742930282736, 6478.902816457663, 6441.04039889292, 6451.612903225821, 6529.412352888263, 6561.40947314744, 6608.372204640552, 6302.180716506825, 6311.905321420274, 6364.93635063662, 6411.358864113551, 6441.710123044568], "value": 5178.420739006967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8044630181358, 909.7043460875215, 927.8608208768684, 928.7678080479884, 942.1944237676784, 16537.17314134293, 17212.05333706647, 17262.913685431555, 17274.04992725403, 17287.654246915055, 15443.382264709426, 15480.767788483154, 15708.685826283467, 15732.449364272225, 16425.342986280564, 935.4480856294784, 950.9334346595741, 952.5808644196566, 957.8946315905245, 958.9424634521916, 973.7955029443825, 973.9269554783419, 974.0503009565688, 974.0697633759743, 975.1321324021626, 971.0920289529313, 1007.8840933292655, 1008.5259927833943, 1016.2987538598344, 1018.9796204075914, 992.8361820299642, 998.0668075349571, 999.6101520407084, 1000.4047591682937, 1000.7197984564334, 737.2848337112991, 739.7595781371076, 740.3189066059239, 741.6143605325254, 744.2631794523382, 16239.51281461558, 16775.0, 16798.32806687731, 17198.226079826312, 17307.394241201622, 21831.45421364463, 22005.33983980483, 22045.11819527217, 22399.888000560055, 22442.102315907345, 16686.33254669812, 17200.56998575033, 17256.913715431343, 17302.307907683677, 17309.221085051202, 3676.8161591920566, 3743.6630703236565, 3785.034816121899, 3787.110029143149, 3789.109559253573, 98021.50989245079, 109647.45176274148, 135346.0, 139218.30390848083, 139496.0, 17476.300947962194, 17667.20497577612, 17676.91161544184, 17839.197236124404, 17855.28578856857, 31076.0, 31287.530687039714, 31643.525347119812, 31829.84085079606, 31988.0, 8690.739277821676, 8705.303575713928, 8716.302695784321, 8734.344924130715, 8754.387192896436, 4221.662267018631, 4265.0403659177055, 4289.699721019499, 4289.978550107292, 4348.891277718019, 5002.274670172805, 5059.949400505948, 5113.923291150636, 5115.693058416507, 5129.538341549204, 1012.6556970630021, 1038.5689938675516, 1039.4875456211194, 1054.0408228512017, 1058.063613701864, 652.8204743695521, 662.7580932959435, 676.0940339944498, 683.111954459201, 683.1699485125497, 10454.738631534272, 10705.090067344363, 10787.394125291974, 11192.0, 11288.661340159808, 647.0682217606632, 658.3087757854233, 659.9276176213652, 665.6139439125295, 673.1719984419094, 4942.654014218971, 5011.728302640159, 5135.948640513622, 5150.124478838607, 5165.14775062118, 123168.0, 123318.38340808418, 124916.0, 125734.37132814278, 129674.35162824126, 108160.4591977035, 108206.0, 109367.0, 111307.0, 114008.42995784969, 89933.55033224923, 95085.0, 95276.0, 96762.0, 97527.0, 9165.908340916505, 9223.169914707709, 9280.350375473652, 9338.393004454689, 9441.575129119343, 42895.0, 43311.0, 44086.33870492009, 44899.551004490844, 45792.77103614461, 55646.16530752123, 55830.162547561005, 56605.71697141488, 56813.715931420076, 57340.1398979024, 14489.492867749577, 14594.708105837612, 14604.0, 14739.631509212355, 14805.777913331092, 16670.58323541921, 16710.58223544421, 16848.326066957183, 16952.745708814626, 17036.233369498652, 13548.25484598317, 13649.0, 13740.93129534346, 13846.723065538834, 13908.0, 13503.12229705066, 13563.932180339036, 13571.932140339235, 13609.795853062014, 13656.590302290948, 14290.499832505813, 14412.279386030446, 14453.566393008226, 14535.927320363331, 14625.85374146245, 10080.64717734905, 10168.949155254177, 10279.074883260542, 10549.314294570828, 10654.680359588914, 11004.724881878017, 11052.392118433241, 11081.403891034975, 11161.609343672932, 11196.776064478829], "value": 8528.25803972961, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 107.0, 116.0, 119.0, 112.0, 110.0, 117.0, 110.0, 109.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 126.0, 117.0, 123.0, 118.0, 118.0, 123.0, 144.0, 119.0, 119.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 163.0, 163.0, 163.0, 170.0, 164.0, 169.0, 163.0, 162.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 80.0, 73.0, 73.0, 77.0, 84.0, 83.0, 75.0, 84.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 81.0, 80.0, 96.0, 82.0, 87.0, 88.0, 83.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 110.0, 114.0, 116.0, 118.0, 117.0, 114.0, 122.0, 112.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 149.0, 149.0, 149.0, 150.0, 149.0, 148.0, 148.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 98.0, 95.0, 103.0, 94.0, 97.0, 95.0, 96.0, 98.0, 95.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 51.0, 52.0, 56.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 40.0, 39.0, 47.0, 47.0, 48.0, 45.0, 47.0], "value": 42.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 74.0, 79.0, 80.0, 78.0, 73.0, 72.0, 75.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 112.0, 112.0, 117.0, 118.0, 112.0, 124.0, 113.0, 112.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 179.0, 172.0, 185.0, 175.0, 173.0, 178.0, 176.0, 177.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 66.0, 66.0, 63.0], "value": 66.6, "unit": "score"}]}]} 03:46:18 INFO - Return code: 0 03:46:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:18 INFO - # TBPL SUCCESS # 03:46:18 INFO - Running post-action listener: _package_coverage_data 03:46:18 INFO - Running post-action listener: _resource_record_post_action 03:46:18 INFO - [mozharness: 2017-09-12 10:46:18.275312Z] Finished run-tests step (success) 03:46:18 INFO - Running post-run listener: _resource_record_post_run 03:46:18 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 18776064; Write bytes: 423981056; Read time: 14228; Write time: 915800 03:46:18 INFO - TinderboxPrint: CPU usage
13.4% 03:46:18 INFO - TinderboxPrint: I/O read bytes / time
18,776,064 / 14,228 03:46:18 INFO - TinderboxPrint: I/O write bytes / time
423,981,056 / 915,800 03:46:18 INFO - TinderboxPrint: CPU idle
8,332.6 (86.6%) 03:46:18 INFO - TinderboxPrint: CPU user
1,202.6 (12.5%) 03:46:18 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 7925760; Read time: 0; Write time: 1132 03:46:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:46:18 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 18673664; Write bytes: 416055296; Read time: 14212; Write time: 914668 03:46:18 INFO - Running post-run listener: _upload_blobber_files 03:46:18 INFO - Blob upload gear active. 03:46:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:18 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 03:46:18 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'] 03:46:18 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 03:46:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:20 INFO - (blobuploader) - INFO - Done attempting. 03:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:26 INFO - (blobuploader) - INFO - Done attempting. 03:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:27 INFO - (blobuploader) - INFO - Done attempting. 03:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:29 INFO - (blobuploader) - INFO - Done attempting. 03:46:29 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:29 INFO - Return code: 0 03:46:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf4de64757526f92dda2a4bf5bd1e274366ac1924fb437f3b9a1f78a151dc44cb9cb8d65b10fa9594484b3b9a41b8bb5531aefc8d22ed45f77c8a6337fb4d62e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b93cfe9027ce1306c310081b6f493e48904b3975e9590759ef5932ab7558417c8e1a2451d14c5a62b54b3a92c64163e2e83209f1981f996c83556dc0ac9a62b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143e6d50b3fdfdae0ac327fafbc206b400ee8dae6f5aa12ccc7b9b72783bfe48bf853dc82c12a28dc8fb197ff97ac9bac9e56d571ac58642402b37cedcaaa416", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b3979ad1bee0aff90286b0f18c0a9aa2c9f66ca2408e9b17635d3760f529c3c43ed3780177830fc0e738393aa1d604cf95ce23b60460241cb5ba1c7762d6fa"} 03:46:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:29 INFO - Contents: 03:46:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf4de64757526f92dda2a4bf5bd1e274366ac1924fb437f3b9a1f78a151dc44cb9cb8d65b10fa9594484b3b9a41b8bb5531aefc8d22ed45f77c8a6337fb4d62e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b93cfe9027ce1306c310081b6f493e48904b3975e9590759ef5932ab7558417c8e1a2451d14c5a62b54b3a92c64163e2e83209f1981f996c83556dc0ac9a62b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143e6d50b3fdfdae0ac327fafbc206b400ee8dae6f5aa12ccc7b9b72783bfe48bf853dc82c12a28dc8fb197ff97ac9bac9e56d571ac58642402b37cedcaaa416", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b3979ad1bee0aff90286b0f18c0a9aa2c9f66ca2408e9b17635d3760f529c3c43ed3780177830fc0e738393aa1d604cf95ce23b60460241cb5ba1c7762d6fa"} 03:46:29 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:29 INFO - Copying logs to upload dir... 03:46:29 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.580873 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-09-12 03:46:29.203930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:29.208908) ========= 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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf4de64757526f92dda2a4bf5bd1e274366ac1924fb437f3b9a1f78a151dc44cb9cb8d65b10fa9594484b3b9a41b8bb5531aefc8d22ed45f77c8a6337fb4d62e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b93cfe9027ce1306c310081b6f493e48904b3975e9590759ef5932ab7558417c8e1a2451d14c5a62b54b3a92c64163e2e83209f1981f996c83556dc0ac9a62b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143e6d50b3fdfdae0ac327fafbc206b400ee8dae6f5aa12ccc7b9b72783bfe48bf853dc82c12a28dc8fb197ff97ac9bac9e56d571ac58642402b37cedcaaa416", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b3979ad1bee0aff90286b0f18c0a9aa2c9f66ca2408e9b17635d3760f529c3c43ed3780177830fc0e738393aa1d604cf95ce23b60460241cb5ba1c7762d6fa"} build_url:https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf4de64757526f92dda2a4bf5bd1e274366ac1924fb437f3b9a1f78a151dc44cb9cb8d65b10fa9594484b3b9a41b8bb5531aefc8d22ed45f77c8a6337fb4d62e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b93cfe9027ce1306c310081b6f493e48904b3975e9590759ef5932ab7558417c8e1a2451d14c5a62b54b3a92c64163e2e83209f1981f996c83556dc0ac9a62b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/143e6d50b3fdfdae0ac327fafbc206b400ee8dae6f5aa12ccc7b9b72783bfe48bf853dc82c12a28dc8fb197ff97ac9bac9e56d571ac58642402b37cedcaaa416", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8b3979ad1bee0aff90286b0f18c0a9aa2c9f66ca2408e9b17635d3760f529c3c43ed3780177830fc0e738393aa1d604cf95ce23b60460241cb5ba1c7762d6fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:29.236823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:29.237139) ========= 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=8783db0840cc980e80bb0bd400000236-1505209924.482890-1002281194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:29.321854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:29.322159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:29.322443) ========= ========= Total master_lag: 0.27 =========