builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-076 starttime: 1505211924.51 results: success (0) revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.512226) ========= 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.512623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.512899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.584338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.584705) ========= 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=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 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% 117M=0s 2017-09-12 03:25:24 (117 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132702 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.754500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.754803) ========= 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=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063155 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.836746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:24.837075) ========= 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=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 03:25:24,800 truncating revision to first 12 chars 2017-09-12 03:25:24,800 Setting DEBUG logging. 2017-09-12 03:25:24,800 attempt 1/10 2017-09-12 03:25:24,800 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,061 unpacking tar archive at: mozilla-central-175f1366daee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531729 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.388595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.388937) ========= script_repo_revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.389346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.389631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:25:25.402683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-12 03:25:25.403070) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 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-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', 03:25:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:25 INFO - 'branch': 'Firefox-Non-PGO', 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-stylo-disabled-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-076', 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.597645Z] 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:30 INFO - Running post-action listener: _resource_record_post_action 03:25:30 INFO - [mozharness: 2017-09-12 10:25:30.814470Z] Finished clobber step (success) 03:25:30 INFO - [mozharness: 2017-09-12 10:25:30.814646Z] Running read-buildbot-config step. 03:25:30 INFO - Running pre-action listener: _resource_record_pre_action 03:25:30 INFO - Running main action method: read_buildbot_config 03:25:30 INFO - Using buildbot properties: 03:25:30 INFO - { 03:25:30 INFO - "project": "", 03:25:30 INFO - "product": "firefox", 03:25:30 INFO - "who": "archaeopteryx@coole-files.de", 03:25:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:25:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:25:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:25:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:25:30 INFO - "stage_platform": "linux64", 03:25:30 INFO - "basedir": "/builds/slave/test", 03:25:30 INFO - "buildnumber": 9, 03:25:30 INFO - "platform": "ubuntu64_hw", 03:25:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:30 INFO - "slavebuilddir": "test", 03:25:30 INFO - "taskId": "N4-VzsUFS9an_XR1CXjpZA", 03:25:30 INFO - "branch": "mozilla-central", 03:25:30 INFO - "script_repo_revision": "production", 03:25:30 INFO - "revision": "175f1366daee80cde53386a4627402ed3af4c038", 03:25:30 INFO - "slavename": "talos-linux64-ix-076", 03:25:30 INFO - "repo_path": "mozilla-central" 03:25:30 INFO - } 03:25:30 INFO - Finding installer, test and symbols from parent task. 03:25:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4-VzsUFS9an_XR1CXjpZA'}, attempt #1 03:25:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N4-VzsUFS9an_XR1CXjpZA'}, attempt #1 03:25:31 INFO - Task dependencies: c8J8p6RuRZ-xxUSm_NtOkg 03:25:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg'}, attempt #1 03:25:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.crashreporter-symbols.zip 03:25:32 INFO - Running post-action listener: _resource_record_post_action 03:25:32 INFO - [mozharness: 2017-09-12 10:25:32.192617Z] Finished read-buildbot-config step (success) 03:25:32 INFO - [mozharness: 2017-09-12 10:25:32.192835Z] Running download-and-extract step. 03:25:32 INFO - Running pre-action listener: _resource_record_pre_action 03:25:32 INFO - Running main action method: download_and_extract 03:25:32 INFO - mkdir: /builds/slave/test/build/tests 03:25:32 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:32 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.test_packages.json 03:25:32 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:32 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:32 INFO - Downloaded 989 bytes. 03:25:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:25:32 INFO - Using the following test package requirements: 03:25:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:25:32 INFO - u'common': [u'target.common.tests.zip'], 03:25:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:25:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:25:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:25:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:25:32 INFO - u'mozbase': [u'target.common.tests.zip'], 03:25:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:25:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:25:32 INFO - u'web-platform': [u'target.common.tests.zip', 03:25:32 INFO - u'target.web-platform.tests.tar.gz'], 03:25:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:25:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:25:32 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:32 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:32 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.common.tests.zip into memory 03:25:33 INFO - Content-Length response header: 55043807 03:25:33 INFO - Bytes received: 55043807 03:25:44 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:44 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:44 INFO - Fetch https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.talos.tests.zip into memory 03:25:45 INFO - Content-Length response header: 14499231 03:25:45 INFO - Bytes received: 14499231 03:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:45 INFO - trying https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:45 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:45 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:46 INFO - Downloaded 63128717 bytes. 03:25:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:46 INFO - mkdir: /builds/slave/test/properties 03:25:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:46 INFO - Contents: 03:25:46 INFO - build_url:https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2 03:25:46 INFO - Running post-action listener: _resource_record_post_action 03:25:46 INFO - Running post-action listener: find_tests_for_verification 03:25:46 INFO - Running post-action listener: set_extra_try_arguments 03:25:46 INFO - [mozharness: 2017-09-12 10:25:46.833278Z] Finished download-and-extract step (success) 03:25:46 INFO - [mozharness: 2017-09-12 10:25:46.833395Z] Running populate-webroot step. 03:25:46 INFO - Running pre-action listener: _resource_record_pre_action 03:25:46 INFO - Running main action method: populate_webroot 03:25:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['tresize', 03:25:46 INFO - 'tcanvasmark']}, 03:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['dromaeo_css', 03:25:46 INFO - 'kraken']}, 03:25:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['damp', 'tps']}, 03:25:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['damp', 'tps']}, 03:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['dromaeo_dom']}, 03:25:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['basic_compositor_video', 03:25:46 INFO - 'glvideo']}, 03:25:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['ts_paint_webext', 03:25:46 INFO - 'tp5o_webext']}, 03:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:46 INFO - 'ts_paint', 03:25:46 INFO - 'tpaint', 03:25:46 INFO - 'sessionrestore', 03:25:46 INFO - 'sessionrestore_many_windows', 03:25:46 INFO - 'sessionrestore_no_auto_restore', 03:25:46 INFO - 'tabpaint']}, 03:25:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['a11yr', 03:25:46 INFO - 'ts_paint', 03:25:46 INFO - 'tpaint', 03:25:46 INFO - 'sessionrestore', 03:25:46 INFO - 'sessionrestore_many_windows', 03:25:46 INFO - 'sessionrestore_no_auto_restore', 03:25:46 INFO - 'tabpaint']}, 03:25:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['bloom_basic']}, 03:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:46 INFO - 'tsvgr_opacity', 03:25:46 INFO - 'tart', 03:25:46 INFO - 'tscrollx', 03:25:46 INFO - 'tsvg_static']}, 03:25:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['tsvgx', 03:25:46 INFO - 'tsvgr_opacity', 03:25:46 INFO - 'tart', 03:25:46 INFO - 'tscrollx', 03:25:46 INFO - 'tsvg_static']}, 03:25:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo'], 03:25:46 INFO - 'tests': ['tp5o']}, 03:25:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo', 03:25:46 INFO - '--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:46 INFO - 'talos_options': ['--stylo-threads=1', 03:25:46 INFO - '--mitmproxy', 03:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:46 INFO - '--firstNonBlankPaint'], 03:25:46 INFO - 'tests': ['tp6_google', 03:25:46 INFO - 'tp6_youtube', 03:25:46 INFO - 'tp6_amazon', 03:25:46 INFO - 'tp6_facebook']}, 03:25:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--xperf_path', 03:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:46 INFO - 'tests': ['tp5n']}, 03:25:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:46 INFO - 'talos_options': ['--disable-stylo', 03:25:46 INFO - '--xperf_path', 03:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:46 INFO - 'tests': ['tp5n']}}} 03:25:46 INFO - Running post-action listener: _resource_record_post_action 03:25:46 INFO - [mozharness: 2017-09-12 10:25:46.852303Z] Finished populate-webroot step (success) 03:25:46 INFO - [mozharness: 2017-09-12 10:25:46.852411Z] Running create-virtualenv step. 03:25:46 INFO - Running pre-action listener: _resource_record_pre_action 03:25:46 INFO - Running main action method: create_virtualenv 03:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:25:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:48 INFO - Installing pip...............done. 03:25:48 INFO - Return code: 0 03:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:48 INFO - Reading from file tmpfile_stdout 03:25:48 INFO - Output received: 03:25:48 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:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:48 INFO - Using env: {'DISPLAY': ':0', 03:25:48 INFO - 'HOME': '/home/cltbld', 03:25:48 INFO - 'LANG': 'en_US.UTF-8', 03:25:48 INFO - 'LANGUAGE': 'en_US:en', 03:25:48 INFO - 'LOGNAME': 'cltbld', 03:25:48 INFO - 'MAIL': '/var/mail/cltbld', 03:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:48 INFO - 'MOZ_NO_REMOTE': '1', 03:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:48 INFO - 'NO_EM_RESTART': '1', 03:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:48 INFO - 'PWD': '/builds/slave/test', 03:25:48 INFO - 'SHELL': '/bin/bash', 03:25:48 INFO - 'SHLVL': '1', 03:25:48 INFO - 'TERM': 'linux', 03:25:48 INFO - 'TMOUT': '86400', 03:25:48 INFO - 'USER': 'cltbld', 03:25:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:48 INFO - '_': '/tools/buildbot/bin/python'} 03:25:49 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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:49 INFO - '_': '/tools/buildbot/bin/python'} 03:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:49 INFO - Downloading/unpacking psutil>=3.1.1 03:25:49 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:49 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:49 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:49 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:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:51 INFO - Installing collected packages: psutil 03:25:51 INFO - Running setup.py install for psutil 03:25:51 INFO - building 'psutil._psutil_linux' extension 03:25:51 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:52 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:52 INFO - building 'psutil._psutil_posix' extension 03:25:52 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:52 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:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:52 INFO - Successfully installed psutil 03:25:52 INFO - Cleaning up... 03:25:52 INFO - Return code: 0 03:25:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:52 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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 03:25:52 INFO - 'HOME': '/home/cltbld', 03:25:52 INFO - 'LANG': 'en_US.UTF-8', 03:25:52 INFO - 'LANGUAGE': 'en_US:en', 03:25:52 INFO - 'LOGNAME': 'cltbld', 03:25:52 INFO - 'MAIL': '/var/mail/cltbld', 03:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:52 INFO - 'MOZ_NO_REMOTE': '1', 03:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:52 INFO - 'NO_EM_RESTART': '1', 03:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:52 INFO - 'PWD': '/builds/slave/test', 03:25:52 INFO - 'SHELL': '/bin/bash', 03:25:52 INFO - 'SHLVL': '1', 03:25:52 INFO - 'TERM': 'linux', 03:25:52 INFO - 'TMOUT': '86400', 03:25:52 INFO - 'USER': 'cltbld', 03:25:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:52 INFO - '_': '/tools/buildbot/bin/python'} 03:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:54 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:54 INFO - Installing collected packages: mozsystemmonitor 03:25:54 INFO - Running setup.py install for mozsystemmonitor 03:25:54 INFO - Successfully installed mozsystemmonitor 03:25:54 INFO - Cleaning up... 03:25:54 INFO - Return code: 0 03:25:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:54 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:54 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:54 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:54 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:54 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:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:55 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:55 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:55 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:55 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:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:55 INFO - warning: no files found matching '*.txt' 03:25:55 INFO - no previously-included directories found matching 'build' 03:25:55 INFO - no previously-included directories found matching 'dist' 03:25:55 INFO - no previously-included directories found matching '.git*' 03:25:55 INFO - Installing collected packages: jsonschema, functools32 03:25:55 INFO - Running setup.py install for functools32 03:25:55 INFO - warning: no files found matching '*.txt' 03:25:55 INFO - no previously-included directories found matching 'build' 03:25:55 INFO - no previously-included directories found matching 'dist' 03:25:55 INFO - no previously-included directories found matching '.git*' 03:25:55 INFO - Successfully installed jsonschema functools32 03:25:55 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing functools32==3.2.3-2 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', '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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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', 'functools32==3.2.3-2'] 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 functools32==3.2.3-2 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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing blobuploader==1.2.4 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', '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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 03:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:58 INFO - Downloading docopt-0.6.1.tar.gz 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:58 INFO - Running setup.py install for blobuploader 03:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:58 INFO - Running setup.py install for requests 03:25:58 INFO - Running setup.py install for docopt 03:25:59 INFO - Successfully installed blobuploader requests docopt 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing None 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', '--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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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', '--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:25:59 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: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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Running setup.py (path:/tmp/pip-Xrprfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Running setup.py (path:/tmp/pip-mHvlfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Running setup.py (path:/tmp/pip-WoZ38u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Running setup.py (path:/tmp/pip-798aMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Running setup.py (path:/tmp/pip-XM_2Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Running setup.py (path:/tmp/pip-ZDGLiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Running setup.py (path:/tmp/pip-fx5Sth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:59 INFO - Running setup.py (path:/tmp/pip-2fMBKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:59 INFO - Running setup.py (path:/tmp/pip-yzndLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:59 INFO - Running setup.py (path:/tmp/pip-TcLSg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Running setup.py (path:/tmp/pip-all__g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Running setup.py (path:/tmp/pip-glNkWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Running setup.py (path:/tmp/pip-4zLYti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Running setup.py (path:/tmp/pip-S6KHUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Running setup.py (path:/tmp/pip-kJJiUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Running setup.py (path:/tmp/pip-9c45ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Running setup.py (path:/tmp/pip-vVcQ9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:00 INFO - Running setup.py install for manifestparser 03:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozcrash 03:26:00 INFO - Running setup.py install for mozdebug 03:26:00 INFO - Running setup.py install for mozdevice 03:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:00 INFO - Running setup.py install for mozfile 03:26:01 INFO - Running setup.py install for mozhttpd 03:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozinfo 03:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozInstall 03:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozleak 03:26:01 INFO - Running setup.py install for mozlog 03:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for moznetwork 03:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozprocess 03:26:01 INFO - Running setup.py install for mozprofile 03:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:01 INFO - Running setup.py install for mozrunner 03:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Running setup.py install for mozscreenshot 03:26:02 INFO - Running setup.py install for moztest 03:26:02 INFO - Running setup.py install for mozversion 03:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:02 INFO - Cleaning up... 03:26:02 INFO - Return code: 0 03:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:02 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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:02 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:02 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', '--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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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', '--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 --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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 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-VPaJ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 INFO - Running setup.py (path:/tmp/pip-l_bqA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 INFO - Running setup.py (path:/tmp/pip-R7Zj19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 INFO - Running setup.py (path:/tmp/pip-rZ9cz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:02 INFO - Running setup.py (path:/tmp/pip-TCreAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:02 INFO - Running setup.py (path:/tmp/pip-D936Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:02 INFO - Running setup.py (path:/tmp/pip-8f0ux0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 INFO - Running setup.py (path:/tmp/pip-_2Yfb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:03 INFO - Running setup.py (path:/tmp/pip-DRZsko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:03 INFO - Running setup.py (path:/tmp/pip-b5iARP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 INFO - Running setup.py (path:/tmp/pip-j1uhIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 INFO - Running setup.py (path:/tmp/pip-BmdJhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 INFO - Running setup.py (path:/tmp/pip-aKhB_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 INFO - Running setup.py (path:/tmp/pip-RBW3Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 INFO - Running setup.py (path:/tmp/pip-1po7uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:03 INFO - Running setup.py (path:/tmp/pip-OtHd8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:03 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:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:03 INFO - Running setup.py (path:/tmp/pip-qEatzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:03 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:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:03 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:03 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:03 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:03 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:04 INFO - Downloading blessings-1.6.tar.gz 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:04 INFO - Installing collected packages: blessings 03:26:04 INFO - Running setup.py install for blessings 03:26:05 INFO - Successfully installed blessings 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:05 INFO - Reading from file tmpfile_stdout 03:26:05 INFO - Current package versions: 03:26:05 INFO - argparse == 1.2.1 03:26:05 INFO - blessings == 1.6 03:26:05 INFO - blobuploader == 1.2.4 03:26:05 INFO - docopt == 0.6.1 03:26:05 INFO - functools32 == 3.2.3-2 03:26:05 INFO - jsonschema == 2.5.1 03:26:05 INFO - manifestparser == 1.1 03:26:05 INFO - mozInstall == 1.13 03:26:05 INFO - mozcrash == 1.0 03:26:05 INFO - mozdebug == 0.1 03:26:05 INFO - mozdevice == 0.51 03:26:05 INFO - mozfile == 1.2 03:26:05 INFO - mozhttpd == 0.7 03:26:05 INFO - mozinfo == 0.10 03:26:05 INFO - mozleak == 0.1 03:26:05 INFO - mozlog == 3.5 03:26:05 INFO - moznetwork == 0.27 03:26:05 INFO - mozprocess == 0.25 03:26:05 INFO - mozprofile == 0.28 03:26:05 INFO - mozrunner == 6.13 03:26:05 INFO - mozscreenshot == 0.1 03:26:05 INFO - mozsystemmonitor == 0.3 03:26:05 INFO - moztest == 0.8 03:26:05 INFO - mozversion == 1.4 03:26:05 INFO - psutil == 3.1.1 03:26:05 INFO - requests == 1.2.3 03:26:05 INFO - wsgiref == 0.1.2 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/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 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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/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:05 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: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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 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 - 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:26:05 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:05 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:05 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:05 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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:26:06 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:06 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:06 INFO - Installing collected packages: simplejson 03:26:06 INFO - Running setup.py install for simplejson 03:26:07 INFO - building 'simplejson._speedups' extension 03:26:07 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:07 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:07 INFO - Successfully installed simplejson 03:26:07 INFO - Cleaning up... 03:26:07 INFO - Return code: 0 03:26:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1493a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, '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': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', '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:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:07 INFO - Using env: {'DISPLAY': ':0', 03:26:07 INFO - 'HOME': '/home/cltbld', 03:26:07 INFO - 'LANG': 'en_US.UTF-8', 03:26:07 INFO - 'LANGUAGE': 'en_US:en', 03:26:07 INFO - 'LOGNAME': 'cltbld', 03:26:07 INFO - 'MAIL': '/var/mail/cltbld', 03:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:07 INFO - 'MOZ_NO_REMOTE': '1', 03:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:07 INFO - 'NO_EM_RESTART': '1', 03:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:07 INFO - 'PWD': '/builds/slave/test', 03:26:07 INFO - 'SHELL': '/bin/bash', 03:26:07 INFO - 'SHLVL': '1', 03:26:07 INFO - 'TERM': 'linux', 03:26:07 INFO - 'TMOUT': '86400', 03:26:07 INFO - 'USER': 'cltbld', 03:26:07 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:07 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): jsonschema in ./venv/lib/python2.7/site-packages 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Running post-action listener: _resource_record_post_action 03:26:08 INFO - Running post-action listener: _start_resource_monitoring 03:26:08 INFO - Starting resource monitoring. 03:26:08 INFO - [mozharness: 2017-09-12 10:26:08.231148Z] Finished create-virtualenv step (success) 03:26:08 INFO - [mozharness: 2017-09-12 10:26:08.232229Z] Running install step. 03:26:08 INFO - Running pre-action listener: _resource_record_pre_action 03:26:08 INFO - Running main action method: install 03:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:08 INFO - Reading from file tmpfile_stdout 03:26:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:08 INFO - Reading from file tmpfile_stdout 03:26:08 INFO - Output received: 03:26:08 INFO - Usage: mozinstall [options] installer 03:26:08 INFO - Options: 03:26:08 INFO - -h, --help show this help message and exit 03:26:08 INFO - -d DEST, --destination=DEST 03:26:08 INFO - Directory to install application into. [default: 03:26:08 INFO - "/builds/slave/test"] 03:26:08 INFO - --app=APP Application being installed. [default: firefox] 03:26:08 INFO - mkdir: /builds/slave/test/build/application 03:26:08 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:08 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:25 INFO - Reading from file tmpfile_stdout 03:26:25 INFO - Output received: 03:26:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:25 INFO - Running post-action listener: _resource_record_post_action 03:26:25 INFO - [mozharness: 2017-09-12 10:26:25.157040Z] Finished install step (success) 03:26:25 INFO - [mozharness: 2017-09-12 10:26:25.157291Z] Running setup-mitmproxy step. 03:26:25 INFO - Running pre-action listener: _resource_record_pre_action 03:26:25 INFO - Running main action method: setup_mitmproxy 03:26:25 INFO - Skipping: mitmproxy is not required 03:26:25 INFO - Running post-action listener: _resource_record_post_action 03:26:25 INFO - [mozharness: 2017-09-12 10:26:25.158411Z] Finished setup-mitmproxy step (success) 03:26:25 INFO - [mozharness: 2017-09-12 10:26:25.158631Z] Running run-tests step. 03:26:25 INFO - Running pre-action listener: _resource_record_pre_action 03:26:25 INFO - Running pre-action listener: _set_gcov_prefix 03:26:25 INFO - Running main action method: run_tests 03:26:25 WARNING - Try message not found. 03:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:25 INFO - Python 2.7.3 03:26:25 INFO - Return code: 0 03:26:25 INFO - grabbing minidump binary from tooltool 03:26:25 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:25 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 0x1497090>, '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 0x1497d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1491f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:25 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:25 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:25 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:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:25 INFO - Return code: 0 03:26:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - ENV: RUST_BACKTRACE is now full 03:26:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-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-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:26:25 INFO - Using env: {'DISPLAY': ':0', 03:26:25 INFO - 'HOME': '/home/cltbld', 03:26:25 INFO - 'LANG': 'en_US.UTF-8', 03:26:25 INFO - 'LANGUAGE': 'en_US:en', 03:26:25 INFO - 'LOGNAME': 'cltbld', 03:26:25 INFO - 'MAIL': '/var/mail/cltbld', 03:26:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:25 INFO - 'MOZ_NO_REMOTE': '1', 03:26:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:25 INFO - 'NO_EM_RESTART': '1', 03:26:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:25 INFO - 'PWD': '/builds/slave/test', 03:26:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:25 INFO - 'RUST_BACKTRACE': 'full', 03:26:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:25 INFO - 'SHELL': '/bin/bash', 03:26:25 INFO - 'SHLVL': '1', 03:26:25 INFO - 'TERM': 'linux', 03:26:25 INFO - 'TMOUT': '86400', 03:26:25 INFO - 'USER': 'cltbld', 03:26:25 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:25 INFO - '_': '/tools/buildbot/bin/python'} 03:26:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:26:25 INFO - mozversion application_buildid: 20170912093323 03:26:25 INFO - mozversion application_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:25 INFO - mozversion application_display_name: Nightly 03:26:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:25 INFO - mozversion application_name: Firefox 03:26:25 INFO - mozversion application_remotingname: firefox 03:26:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:25 INFO - mozversion application_vendor: Mozilla 03:26:25 INFO - mozversion application_version: 57.0a1 03:26:25 INFO - mozversion platform_buildid: 20170912093323 03:26:25 INFO - mozversion platform_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:26:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:25 INFO - mozversion platform_version: 57.0a1 03:26:25 INFO - using testdate: 1505211985 03:26:25 INFO - actual date: 1505211985 03:26:25 INFO - starting webserver on 'localhost:35567' 03:26:25 INFO - SUITE-START | Running 2 tests 03:26:25 INFO - TEST-START | dromaeo_css 03:26:25 INFO - Initialising browser for dromaeo_css test... 03:26:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35567/getInfo.html -profile /tmp/tmp5sYg7e/profile 03:26:25 INFO - TEST-INFO | started process 3601 (/builds/slave/test/build/application/firefox/firefox http://localhost:35567/getInfo.html) 03:26:34 INFO - TEST-INFO | 3601: exit 0 03:26:34 INFO - Browser initialized. 03:26:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:34 INFO - Using env: {'DISPLAY': ':0', 03:26:34 INFO - 'HOME': '/home/cltbld', 03:26:34 INFO - 'JSGC_DISABLE_POISONING': '1', 03:26:34 INFO - 'LANG': 'en_US.UTF-8', 03:26:34 INFO - 'LANGUAGE': 'en_US:en', 03:26:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:26:34 INFO - 'LOGNAME': 'cltbld', 03:26:34 INFO - 'MAIL': '/var/mail/cltbld', 03:26:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:34 INFO - 'MOZ_CRASHREPORTER': '1', 03:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:26:34 INFO - 'MOZ_NO_REMOTE': '1', 03:26:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:34 INFO - 'NO_EM_RESTART': '1', 03:26:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:34 INFO - 'PWD': '/builds/slave/test', 03:26:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:34 INFO - 'RUST_BACKTRACE': 'full', 03:26:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:26:34 INFO - 'SHELL': '/bin/bash', 03:26:34 INFO - 'SHLVL': '1', 03:26:34 INFO - 'STYLO_FORCE_DISABLED': '1', 03:26:34 INFO - 'TERM': 'linux', 03:26:34 INFO - 'TMOUT': '86400', 03:26:34 INFO - 'USER': 'cltbld', 03:26:34 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:34 INFO - '_': '/tools/buildbot/bin/python'} 03:26:34 INFO - TEST-INFO | started process 3806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5sYg7e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:35 INFO - PID 3806 | 03:26:35 INFO - PID 3806 | (/builds/slave/test/build/application/firefox/firefox:3857): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:35 INFO - PID 3806 | 03:26:46 INFO - PID 3806 | RSS: Main: 164085760 03:26:46 INFO - PID 3806 | 03:29:42 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35567/tests/dromaeo/cssquery-ext.html) 03:29:43 INFO - PID 3806 | RSS: Main: 168407040 03:29:43 INFO - PID 3806 | 03:32:45 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-ext.html (next: http://localhost:35567/tests/dromaeo/cssquery-jquery.html) 03:32:45 INFO - PID 3806 | RSS: Main: 167010304 03:32:45 INFO - PID 3806 | 03:35:47 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35567/tests/dromaeo/cssquery-mootools.html) 03:35:48 INFO - PID 3806 | RSS: Main: 169594880 03:35:48 INFO - PID 3806 | 03:38:49 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35567/tests/dromaeo/cssquery-prototype.html) 03:38:50 INFO - PID 3806 | RSS: Main: 168099840 03:38:50 INFO - PID 3806 | 03:41:53 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35567/tests/dromaeo/cssquery-yui.html) 03:41:54 INFO - PID 3806 | RSS: Main: 168824832 03:41:54 INFO - PID 3806 | 03:44:55 INFO - PID 3806 | Cycle 1(1): loaded http://localhost:35567/tests/dromaeo/cssquery-yui.html (next: http://localhost:35567/tests/dromaeo/cssquery-dojo.html) 03:44:56 INFO - PID 3806 | RSS: Main: 172273664 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | __start_tp_report 03:44:56 INFO - PID 3806 | _x_x_mozilla_page_load 03:44:56 INFO - PID 3806 | _x_x_mozilla_page_load_details 03:44:56 INFO - PID 3806 | |i|pagename|runs| 03:44:56 INFO - PID 3806 | |0;dojo.html;3133.514305282681;3157.6368717597484;3161.4625513662677;3167.3981943430745;3168.6356069052067;6166.506679465643;6220.284667263266;6256.84357891053;6333.08170315304;6420.422162005424;6264.436200741932;6277.686115694209;6295;6299.527535434838;6307.432331090201;5810.418958104198;5825.970870145665;5875.88248235035;5888.970555147218;5902.940970590304;5813.622114562561;5832.533397328225;5860.912086318709;5861.472467477926;5875.059990401536;28.380593545861586;5391.622586418933;5665.688387138705;5854.677992710399;5912.142739302799;5723.141528770676;5729.255196824428;5776.249087618583;5795.536357091422;5878.2064421303;5759.1937128802;5779.248697669318;5847.502962248214;5855.3851845556455;5856.97071514644;6269.153664255313;6299.181106456177;6317.589356691847;6363.395477429637;6370.076338930876;6492.123563318986;6726.0919775830125;6734.326567343275;6818;6835.658217089126;6720.49596280276;6780.32196780318;6837.247902730695;6838.14523184602;6839.931600683979;6284.057391391282;6289.685515724242;6356.237251529799;6369.93630063698;6377.298497165308;6898.655067246617;6959;6998.265182155902;7014;7041.155061392666;6421.229452465641;6508.9023664645065;6523.608583485006;6535.215774107042;6563.146790917151;6638.435732962752;6683.565568238049;6704.631245281459;6801.809683305401;6802.693878775467;6727.327267273234;6792.76225332111;6801.353871382211;6803.625800580917;6811.080504131879;6738.663066846638;6757.087793147961;6760.594364338155;6849;6858.5199036067;5185.507376799198;5251.868703282372;5291.365036195682;5348;5353.2773075634295;4579.107074120515;4582.518835522289;4643.233866412072;4674.439067311876;4752.881177970578;5825.359210486843;5870.882582348415;5891.1457838614015;5893.734781934823;5895.204147440127;6783.93216067833;6796.830079248059;6807.795766127024;6873;6894.96575513677;5640.238567793377;5773.971130144322;5800.1299805029585;5878.030125029322;5902.468777810018;5853.2976042875125;5871;5873.20711703923;5887.2052272943465;5888.823335299948;6521.315261897433;6528.347165283529;6612.2726500084955;6614.801555953329;6619.867602648016;6778.694958726771;6784.185897692209;6809.7276108956075;6872.793816185523;6878.518503704692;6322.557420980487;6436.710348034256;6463.870722585616;6479.222493300834;6536.439139489131;6569.113169722217;6595.307492713388;6656.567323123982;6746.831329216612;6754.223264324469;6810.148731408574;6821.761238356634;6884.4148247397525;6904.516683832084;6915.03189553473;6543.0185472179555;6553.770618028537;6618.106555614931;6629.337066293525;6635.900461493178;6475.449586784987;6541.149650545589;6573.638449885302;6613.503987200883;6622.602643841385;6522.510811689048;6551.115599394021;6558.049082883051;6566.212054553484;6567.080608714879;6497.18785151856;6502.349765023459;6589;6633.1045308882685;6675.632840193836;6248.281447633581;6357.904631430625;6386.616802991835;6397.26431460388;6404.263509696445 03:44:56 INFO - PID 3806 | |1;ext.html;807.7374853172716;846.437119315655;868.9044205137434;869.1395518436746;871.3116637856094;39168.60831391692;41161.79419102904;41904.37143442851;41970.58029419705;42718.57281427185;42463.575364246346;42772.57227427725;42788.78605606968;42862.35706464398;42866.14267714644;7727.2659097385795;7857.960710196441;7868.449208555404;7870.606469676522;7876.645550950221;7755.49589276698;7871.960640196819;7876.724314648988;7882.330001949841;7889.289963903248;7840.333571646417;7875;7879.212078792104;7893.881591776128;7898.80252993674;7830.099538553054;7869.449138560303;7876.763697089096;7878.369730421553;7884.842303153933;7692.115406728242;7779.37764978806;7780.066392032993;7783.571903545303;7784.182660820589;37988.62011379906;38082.809585951894;38090.80954595237;38176.23647527062;38263.617363826284;3492.057144570977;3518.40187168182;3531.6644918732677;3532.947005794915;3537.540119784437;32084.839575801972;32091.83954080238;32125;32132.83933580317;32145;5005.674631149;5178.352705911761;5211.557017653504;5228.738563071869;5230.450802665741;175835;178104;178501;178559;178972.10513947476;44631.55368446339;44716.55283447189;44748.552514475086;44807.55192448099;44826.77586612046;46563;46588;46646.300305495446;46658.30012549814;46691.29963050557;15690.058596484247;15897.205139742966;15902.840971590367;15922.522324330288;15964.840351596567;13102.803457947948;13114.213147211198;13139.080264381593;13160.078794484294;13161.60515184546;12181.451834667461;12446.937765311297;12501.937490312672;12573.622791316275;12631.242125472501;5080.59355251579;5087.287779710843;5109.131447653907;5173.301604283373;5197.324347834758;994.0755097759009;998.9001099889953;1000.4547521600745;1003.5835128421623;1018.2159737002466;22331.88834055852;22390.55218895613;22513.774862251496;22661.20685776023;22688.65967010496;1099.912007039435;1114.9832752508719;1121.5513794482272;1127.8646562412564;1129.0854407929603;11907.345096019802;11947.462364193632;11984.700382490508;12046.698832529257;12074.456649450796;209045;209783;210611;243163;248186;58858;59233.40766592279;59265;59331.40668593259;59360;1473.82314122306;1475.365592795087;1485.8439863814144;1487.2340744516582;1493.6489924867647;27070.72929270682;27411.451770964868;27428;27482.17553473399;27706.861465692542;36973.26053478969;37152.25695486021;37428.43857342088;37428.81285593555;37525.249495010496;196503;197598;197641;197878;197992;34397.82801085978;34629.13427164341;34790;34854.12864678403;35036.474452882714;44424.77787611041;44437.33343999907;44452.33321500245;44461.33308000447;44888;31303.261277021116;31566.526502102945;31795.364092717555;31823.893099322268;31891.6810831898;31377;31657;31799.205019874687;31947.68052319447;32177.517337240428;35956.28087438289;35970.82014590015;36017.63982360143;36030.63969360273;36207.275854482235;30644;30692.232694182825;30778.230544236572;31212.687873121886;31503;21956.451088722908;22319.77241251747;22436.66345004859;22743;22937.426564336027 03:44:56 INFO - PID 3806 | |2;jquery.html;563.2930672006634;569.4447913284548;575.2119596153266;575.7840809696366;587.691461982459;22133.114675412984;23013.309600711986;23030;23041.539169216605;23061.654075188886;23757.524849503043;24169.39576510588;24555.386115347126;25353.49293014143;25526;6405.007223880294;6480.060391243291;6494.447971922392;6505.967470162643;6511.804645860631;6435.131257280277;6435.6138631682015;6552.148220731298;6558.147440832685;6708.027336036272;6626.2048554173325;6673.799786006428;6683.766068187614;6689.431398331148;6690.096836927001;6232.0963460298;6684.197896252432;6688.197416310049;6692.364225398628;6701.329867013308;6047.0627052806885;6064.605800622945;6065.60573562717;6067.575269731121;6067.939320606782;28397.574036389266;28846;28881.277968050756;28909.56635650467;28941.42117157645;2061.4228016155503;2093.110428068065;2098.9580208395746;2100.9474763130893;2102.2326850699383;18538.907305463385;19091.140898659592;19249.13378897953;19333.51666208356;19588.118534665973;2424.3454267347893;2444.3500637070083;2460.065175233418;2485.3413845331;2486.78862296705;118494.40752796181;124365.37817310856;125044;133351.33324333414;141482.99999999898;14852;14864.925630405201;14947.982022427052;14980.550583482513;15200.847991519944;23152.884235578713;23161;23170.884145579163;23221.419464513183;23231.651525227135;10048.09567138961;10050;10109.443980581138;10110.69667909964;10349.482525873676;9260.21288190498;9369.297302702325;9378.906210937803;9446.480443575532;9475.76310592227;8866.335024873031;8892.110788921056;8893.599788009555;8897.644094236159;9129.269658427309;2567.717551069381;2578.9226323210332;2680.7185245548935;2702.1083042595897;2746.1761471558452;940.9247260219166;942.5004747483845;955.7515046087929;966.6133546581283;969.4328817641758;19491.22035118608;19540;19813.900930495543;19819.027145928227;20109.09509072095;1038.6520515627349;1045.5608644369383;1052.7999680060764;1058.8358804385332;1066.8879767624444;10971.23201375896;10973.231873768918;10993.890061099286;11012.724681882857;11091.500882460146;472944;473616;482853;487962;496530;109178.45410773055;112118;113023;113658;114604;1137.7496950671004;1152.654203738875;1176.4294317256124;1185.2829038431796;1189.102227817992;17281.56796080108;17398.913005434893;17520.561985950455;18011.5497112568;18094.5476363092;56439.43560564506;57414.7129264351;57906;58467.4153258479;60410.69794650999;67870;68652.656736718;71947.28052719406;72108;72679.27320726936;14389.64025899319;14672;14699.674150070678;14781.334839932013;14806.555803325917;22757.43106422353;22880.54238915179;22957.540849183257;23109.653355200022;23138.421539461648;17990;18070.186841592422;18560.814391855907;18570.25718971226;18595.44213673592;15504.457343993357;15869.841301586835;16759;16814.747778783574;16870.746938796172;18525.53686157857;18542.44372668822;18579;18607.162677679265;18708.345207917657;14351.928240358731;14460.855391446372;14468.421263149356;14505.419783208554;14523.273836308354;17641.82358176402;17736.467905962843;17814.91092544581;17815.198316075548;18015.459536213933 03:44:56 INFO - PID 3806 | |3;mootools.html;1173.3312012153071;1253.3670496399318;1256.3529782162186;1364.8398860968173;1410.6614412540994;15529.378824847006;15964.680706385865;15978.600534986632;16017.919910400446;16020.59948501288;15616.921915390436;15742.29159687814;15743.448979285728;15750.054996700206;15772.290246938886;2782.6939036705944;2829.8868045278164;2848.145556333102;2863.584780206869;2874.6694130174983;2764.226016715323;2796.8881244750187;2799.762020228283;2800.3979144483933;2812.8312301261885;2772.88908443662;2864.8281103133772;2866.3693987322754;2866.4410439964113;2872.8707208175683;2791.330080780618;2799.300174956261;2814.845183514906;2820.703826098251;2825.8163219390776;2756.8759405826786;2776.4585905748386;2787.637607111083;2794.9441011179865;2797.4125433658955;14947.626309342244;15286.847131528653;15294.388224471008;15294.847051529454;15295.388184472607;8033;8341.290990265834;8348.290395316406;8352.498850068954;8361.83276334476;5280.2079688046715;5406;5472.7263636818;5511.063119269694;5568.916466253009;1890.1305399516239;1926.9807301926942;1940.5827747034314;1973.3586584359996;2002.499375156211;26464.0737574184;26699.332516687045;26711.866440667865;26801.463970720477;26843;6588.571742836701;6698.229703584053;6862.794116176523;6907.689153988083;7053.0830991970715;17255.74116388255;17260.309587616604;17271.3955011574;17286.22212000463;17286.913565432344;7929.405294602928;8093.676252949816;8098.028236611644;8099.716509922242;8100;7428.071491063617;7443.702251909863;7471.4396420268695;7476.476646634684;7502.3622992046285;5165.715885626327;5337.226102215157;5343.19852022192;5362.785488580491;5391.406945236021;1359.9796003059962;1399.1605036977733;1546.5746919596975;1554.7901033360579;1575.763635454691;894.3471265975744;904.6381447420953;919.4253591505309;920.7375897869075;927.8329900617819;7606.847863042708;7612.8477430451085;7657.655405506765;7724.266194711493;7736.458447908705;992.5235886774389;999.9750006249902;1001.234055947201;1007.7631756537207;1007.8992100789862;4534.886627834265;4653.395058642355;4677.976610116928;4708.693934894221;4756.762161891892;21421.89289053576;21623.891880540497;22149.889250553642;22178.667319990214;22310.219142330265;21294.893525532272;21422.250221242495;21819.90900454971;22019;22024.779752202274;11379;11493.827592586118;11519;11565.248258863146;11568.421578921188;7646.847063058819;7851.332636725942;7914.24814642608;7946.602669866599;7984.401169912164;18374.08129593542;18819.153138109094;18966.241350346383;19105.331313403964;19170.137343819282;19510.512237194183;19575.80424195797;19756.11097500587;19785.802141978395;19912.402627921187;10711.94644026775;10740.4092774895;10839.349639021368;10844.18668599874;10916.235863489479;12986.480540778262;13070.607881763563;13108.737825243252;13120.868791312347;13153.408096635865;11173.664790056311;11235.101191904465;11329.830052549054;11402.600908968478;11477.94261028723;11068.39123848164;11123.888761112285;11134.443277835913;11245.325280483197;11407.600733974272;9537.093976072261;9695.466749328854;9702.708918732167;9704.417734935927;9706.369086009669;6879.071325371011;6880.58716477013;6892;6911.654417279216;6924.723011079501;6817.625030623363;6817.89773153413;6858.794236172923;6933.965330173317;6934.895976560457 03:44:56 INFO - PID 3806 | |4;prototype.html;500.09482836066724;504.5685938522563;518.846940152655;524.5908191610542;525.3287035424864;6144.494598823283;6182.165407669963;6303.14907487489;6344.572471193979;6376.808695739123;6211.453304145301;6238.344973777756;6254.21822272216;6271.874562508759;6310.684465776704;5138.229265610151;5161.380634323877;5177.378714554259;5205.635605507616;5231.372235331746;4848.418189817226;5039.244113383003;5041.294218809369;5076.375559820859;5163.535281824635;4979.502049795028;5004.9729859407;5011.448740638527;5052.9747351263195;5063.392392912837;4946.1344264753525;4989.05645669057;5000.224965130411;5015.423226328982;5022.497750224985;4480.103979204172;4515.61617262533;4542.38677778499;4569.9314510282375;4575.313702944552;6156.84607884802;6252.218472690914;6276.278228003793;6277.937220627781;6305.432511074026;5687.914681279784;5700.572457065737;5723.771049158028;5723.971380143114;5740.368559458456;6572.37562431573;6590.835229119262;6610.834729131762;6618.801435956929;6657.600543967329;4892.75536223191;4932.8520144395725;4943;4953.2168419369;4958.429780575244;6815.591064536144;6884.793456196322;6933.757318493828;6947.027416161742;6964.408025317804;4995.575376093;5025.79896804131;5042.949570504248;5047.419546752097;5054.711048682562;5077.365329333833;5133.435322114565;5136.640435169502;5140.46025167352;5142.9742851286255;5721.485066344049;5724.255846739898;5730.025895597759;5744.310682718101;5748;6367.840803979845;6558.213014438298;6666.83332916681;6684;6709.731610735614;1654.4374912529797;1720.8623310135158;1747.9126043697763;1750.5011071844717;1752.772139621841;1212.9757404851853;1218.8842060004285;1222.462116668663;1233.23647184527;1239.0954603139758;5595.776168953196;5650.29371328584;5674.546036317085;5711.200431939532;5802.071668533014;6585.805884146185;6619.470442364599;6655.267920528738;6711.563748356341;6792.626405547742;5713.457221563945;5734.254546908875;5739.741711622987;5826.766144789598;5830.76676932918;3562.91092722684;3582.829196161416;3590.281943611288;3608.386574282378;3609.205974685565;6490.188726409199;6507.772227972093;6552.57408268461;6569.408753212138;6584.7366105356205;6756.844540607589;6845.623490707959;6860.588364698134;6866.622335771581;6895.586264824126;6401.743930242738;6499.237823924813;6511.186101737283;6515.771947981798;6518.57629254097;6562.80311590653;6588.472922166119;6602.438792702674;6623.933760662332;6643.867122657616;6543.378379053982;6646.344510519291;6656.434203092597;6656.76701315471;6661.300563440769;6394.136791533084;6430.742770289323;6466.736642175201;6485.092087107903;6503.447206987459;4904.239842824368;4955.677880937727;4958.8760280993265;4985.725785081855;4987.351644286219;6422.2614399344675;6644.800655980328;6761.256261811099;6762.628055456997;6830.726770929107;6276.874462510816;6495.1556297681;6495.675216239264;6543.411093001652;6571.98134289186;6412.23053233615;6459.418652321314;6471.255805582418;6499.967500162658;6523.499595093061;6329.5252856036905;6344.936550634619;6345.841353966188;6383.6808159592765;6443.903341449975;6202.689865506797;6349.618633273531;6443.09796628463;6488.578242414228;6567.343265673395;6260.311365749672;6330.461910737455;6340.112384266298;6353;6455.160829092188 03:44:56 INFO - PID 3806 | |5;yui.html;913.0686699566438;923.6674797073053;932.0120672087584;939.5912777941596;958.0754571838177;16631.667366652673;17362.91318543407;17409.390671326506;17419.303227870885;19342.709859352122;20195.293164739236;20230;20250.493737656565;20304.796952030476;20398.592028159426;935.4854829843609;953.41365060488;953.4994128082777;953.613786416499;956.9473678947655;951.6954574536152;977.8337682593976;982.5873133284002;990.1633120013577;1000.4997501249376;1042.4318746283257;1045.033344156652;1045.6549338718205;1046.4924511611862;1049.7690508088247;1027.4965267019106;1027.964021259256;1028.3007554862727;1028.331584470093;1028.8302430099025;756.2248695087525;757.4281417529785;758.0713625808396;758.3516093739828;759.0398146344878;18061.27754889803;18454.815451845578;18594.442166735018;18635.161417736097;18654.626907461912;20862.16551337945;20878.269260575806;21226.681599776017;21312.680309795367;21357.145714171413;16926.83073169277;17212.91393543037;17469;17507.5623109422;17508.824911750973;3798.867039653599;3837.827297771607;3841.135744457503;3854.036490877281;3857.4599556062176;137960;139326;139354;140621;141403;16824.15879206035;17144.314227431012;17311.826881731275;17344.82655173432;17353.65292694139;31009;31787.364252715277;31851.84074079615;31883.52174717381;31895.202619934687;8219.424640275243;8307.8338433231;8316.168383161636;8344.8331033379;8415.200555947175;3692.9076773080888;3943.2310699413338;3996.320625493673;3996.8201430935096;4029.073313137995;4178.7283826551175;6013.128096425994;6162.137300777895;6173.104899789595;6194;1111.2721167635211;1144.4449442020614;1161.3380373187372;1162.273579013117;1164.1967042740482;618.7865186510646;629.3266205160526;633.3792882974618;637.2066776862742;646.6637348578713;10904.672859814218;11081.168912331608;11272.380019098864;11312.94343528277;11999.940000300117;614.846288427893;616.4082480818375;616.4451993206061;628.7987843889912;635.2345423764353;5309.150535914235;5325.600579956519;5333.413324534298;5352.732363381815;5354.625176237626;124472;125296;125410.3729481365;125838.37080814537;127198;105702.4714876436;106768.7497815013;109256;109477.45261273642;111532;87915;88834;90510.54744726235;93222;93468;9370.15668589803;9756.951215243878;9763.609455621696;9773.169280611228;9778.559964801743;42654.57345426506;43230;43951.78024109987;44455.77772111119;45916.77041614771;56790.432095678516;57118.71440642936;57336.85326293534;58503;59015.114773279296;14349.784753228501;14725.337359819048;14820.48128315547;14870.256487175815;14960.251987400805;16184;16413;16447.177641118134;17327.393541225996;20219.69670454915;16567.834321656628;16623;16786.916065420082;16852.15739213059;16890.324387024873;16008;16100.597485062966;16139;16267.837321627107;16319.755203671717;15582.844171558592;15652.92173539125;15792.289346979183;15841;15931.601709957344;12655.430505627453;12675.556355527513;12956.481740730642;12981.286029268482;13039;12155.878441215475;12164.026877849928;12225.327606981346;12291.50833966667;12337.074719395901 03:44:56 INFO - PID 3806 | __end_tp_report 03:44:56 INFO - PID 3806 | __start_cc_report 03:44:56 INFO - PID 3806 | _x_x_mozilla_cycle_collect,354 03:44:56 INFO - PID 3806 | __end_cc_report 03:44:56 INFO - PID 3806 | __startTimestamp1505213096062__endTimestamp 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | ------- Summary: start ------- 03:44:56 INFO - PID 3806 | Number of tests: 6 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#0] dojo.html Cycles:165 Average:6179.93 Median:6436.71 stddev:889.79 (13.8%) stddev-sans-first:859.83 03:44:56 INFO - PID 3806 | Values: 3133.5 3157.6 3161.5 3167.4 3168.6 6166.5 6220.3 6256.8 6333.1 6420.4 6264.4 6277.7 6295.0 6299.5 6307.4 5810.4 5826.0 5875.9 5889.0 5902.9 5813.6 5832.5 5860.9 5861.5 5875.1 28.4 5391.6 5665.7 5854.7 5912.1 5723.1 5729.3 5776.2 5795.5 5878.2 5759.2 5779.2 5847.5 5855.4 5857.0 6269.2 6299.2 6317.6 6363.4 6370.1 6492.1 6726.1 6734.3 6818.0 6835.7 6720.5 6780.3 6837.2 6838.1 6839.9 6284.1 6289.7 6356.2 6369.9 6377.3 6898.7 6959.0 6998.3 7014.0 7041.2 6421.2 6508.9 6523.6 6535.2 6563.1 6638.4 6683.6 6704.6 6801.8 6802.7 6727.3 6792.8 6801.4 6803.6 6811.1 6738.7 6757.1 6760.6 6849.0 6858.5 5185.5 5251.9 5291.4 5348.0 5353.3 4579.1 4582.5 4643.2 4674.4 4752.9 5825.4 5870.9 5891.1 5893.7 5895.2 6783.9 6796.8 6807.8 6873.0 6895.0 5640.2 5774.0 5800.1 5878.0 5902.5 5853.3 5871.0 5873.2 5887.2 5888.8 6521.3 6528.3 6612.3 6614.8 6619.9 6778.7 6784.2 6809.7 6872.8 6878.5 6322.6 6436.7 6463.9 6479.2 6536.4 6569.1 6595.3 6656.6 6746.8 6754.2 6810.1 6821.8 6884.4 6904.5 6915.0 6543.0 6553.8 6618.1 6629.3 6635.9 6475.4 6541.1 6573.6 6613.5 6622.6 6522.5 6551.1 6558.0 6566.2 6567.1 6497.2 6502.3 6589.0 6633.1 6675.6 6248.3 6357.9 6386.6 6397.3 6404.3 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#1] ext.html Cycles:180 Average:37084.68 Median:3532.31 stddev:52099.85 (1475.0%) stddev-sans-first:52174.79 03:44:56 INFO - PID 3806 | Values: 807.7 846.4 868.9 869.1 871.3 39168.6 41161.8 41904.4 41970.6 42718.6 42463.6 42772.6 42788.8 42862.4 42866.1 7727.3 7858.0 7868.4 7870.6 7876.6 7755.5 7872.0 7876.7 7882.3 7889.3 7840.3 7875.0 7879.2 7893.9 7898.8 7830.1 7869.4 7876.8 7878.4 7884.8 7692.1 7779.4 7780.1 7783.6 7784.2 37988.6 38082.8 38090.8 38176.2 38263.6 3492.1 3518.4 3531.7 3532.9 3537.5 32084.8 32091.8 32125.0 32132.8 32145.0 5005.7 5178.4 5211.6 5228.7 5230.5 175835.0 178104.0 178501.0 178559.0 178972.1 44631.6 44716.6 44748.6 44807.6 44826.8 46563.0 46588.0 46646.3 46658.3 46691.3 15690.1 15897.2 15902.8 15922.5 15964.8 13102.8 13114.2 13139.1 13160.1 13161.6 12181.5 12446.9 12501.9 12573.6 12631.2 5080.6 5087.3 5109.1 5173.3 5197.3 994.1 998.9 1000.5 1003.6 1018.2 22331.9 22390.6 22513.8 22661.2 22688.7 1099.9 1115.0 1121.6 1127.9 1129.1 11907.3 11947.5 11984.7 12046.7 12074.5 209045.0 209783.0 210611.0 243163.0 248186.0 58858.0 59233.4 59265.0 59331.4 59360.0 1473.8 1475.4 1485.8 1487.2 1493.6 27070.7 27411.5 27428.0 27482.2 27706.9 36973.3 37152.3 37428.4 37428.8 37525.2 196503.0 197598.0 197641.0 197878.0 197992.0 34397.8 34629.1 34790.0 34854.1 35036.5 44424.8 44437.3 44452.3 44461.3 44888.0 31303.3 31566.5 31795.4 31823.9 31891.7 31377.0 31657.0 31799.2 31947.7 32177.5 35956.3 35970.8 36017.6 36030.6 36207.3 30644.0 30692.2 30778.2 31212.7 31503.0 21956.5 22319.8 22436.7 22743.0 22937.4 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#2] jquery.html Cycles:180 Average:34157.56 Median:23035.77 stddev:81091.91 (352.0%) stddev-sans-first:81280.17 03:44:56 INFO - PID 3806 | Values: 563.3 569.4 575.2 575.8 587.7 22133.1 23013.3 23030.0 23041.5 23061.7 23757.5 24169.4 24555.4 25353.5 25526.0 6405.0 6480.1 6494.4 6506.0 6511.8 6435.1 6435.6 6552.1 6558.1 6708.0 6626.2 6673.8 6683.8 6689.4 6690.1 6232.1 6684.2 6688.2 6692.4 6701.3 6047.1 6064.6 6065.6 6067.6 6067.9 28397.6 28846.0 28881.3 28909.6 28941.4 2061.4 2093.1 2099.0 2100.9 2102.2 18538.9 19091.1 19249.1 19333.5 19588.1 2424.3 2444.4 2460.1 2485.3 2486.8 118494.4 124365.4 125044.0 133351.3 141483.0 14852.0 14864.9 14948.0 14980.6 15200.8 23152.9 23161.0 23170.9 23221.4 23231.7 10048.1 10050.0 10109.4 10110.7 10349.5 9260.2 9369.3 9378.9 9446.5 9475.8 8866.3 8892.1 8893.6 8897.6 9129.3 2567.7 2578.9 2680.7 2702.1 2746.2 940.9 942.5 955.8 966.6 969.4 19491.2 19540.0 19813.9 19819.0 20109.1 1038.7 1045.6 1052.8 1058.8 1066.9 10971.2 10973.2 10993.9 11012.7 11091.5 472944.0 473616.0 482853.0 487962.0 496530.0 109178.5 112118.0 113023.0 113658.0 114604.0 1137.7 1152.7 1176.4 1185.3 1189.1 17281.6 17398.9 17520.6 18011.5 18094.5 56439.4 57414.7 57906.0 58467.4 60410.7 67870.0 68652.7 71947.3 72108.0 72679.3 14389.6 14672.0 14699.7 14781.3 14806.6 22757.4 22880.5 22957.5 23109.7 23138.4 17990.0 18070.2 18560.8 18570.3 18595.4 15504.5 15869.8 16759.0 16814.7 16870.7 18525.5 18542.4 18579.0 18607.2 18708.3 14351.9 14460.9 14468.4 14505.4 14523.3 17641.8 17736.5 17814.9 17815.2 18015.5 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#3] mootools.html Cycles:180 Average:9354.55 Median:2774.67 stddev:6767.39 (243.9%) stddev-sans-first:6758.45 03:44:56 INFO - PID 3806 | Values: 1173.3 1253.4 1256.4 1364.8 1410.7 15529.4 15964.7 15978.6 16017.9 16020.6 15616.9 15742.3 15743.4 15750.1 15772.3 2782.7 2829.9 2848.1 2863.6 2874.7 2764.2 2796.9 2799.8 2800.4 2812.8 2772.9 2864.8 2866.4 2866.4 2872.9 2791.3 2799.3 2814.8 2820.7 2825.8 2756.9 2776.5 2787.6 2794.9 2797.4 14947.6 15286.8 15294.4 15294.8 15295.4 8033.0 8341.3 8348.3 8352.5 8361.8 5280.2 5406.0 5472.7 5511.1 5568.9 1890.1 1927.0 1940.6 1973.4 2002.5 26464.1 26699.3 26711.9 26801.5 26843.0 6588.6 6698.2 6862.8 6907.7 7053.1 17255.7 17260.3 17271.4 17286.2 17286.9 7929.4 8093.7 8098.0 8099.7 8100.0 7428.1 7443.7 7471.4 7476.5 7502.4 5165.7 5337.2 5343.2 5362.8 5391.4 1360.0 1399.2 1546.6 1554.8 1575.8 894.3 904.6 919.4 920.7 927.8 7606.8 7612.8 7657.7 7724.3 7736.5 992.5 1000.0 1001.2 1007.8 1007.9 4534.9 4653.4 4678.0 4708.7 4756.8 21421.9 21623.9 22149.9 22178.7 22310.2 21294.9 21422.3 21819.9 22019.0 22024.8 11379.0 11493.8 11519.0 11565.2 11568.4 7646.8 7851.3 7914.2 7946.6 7984.4 18374.1 18819.2 18966.2 19105.3 19170.1 19510.5 19575.8 19756.1 19785.8 19912.4 10711.9 10740.4 10839.3 10844.2 10916.2 12986.5 13070.6 13108.7 13120.9 13153.4 11173.7 11235.1 11329.8 11402.6 11477.9 11068.4 11123.9 11134.4 11245.3 11407.6 9537.1 9695.5 9702.7 9704.4 9706.4 6879.1 6880.6 6892.0 6911.7 6924.7 6817.6 6817.9 6858.8 6934.0 6934.9 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#4] prototype.html Cycles:180 Average:5519.06 Median:6245.28 stddev:1536.06 (24.6%) stddev-sans-first:1493.46 03:44:56 INFO - PID 3806 | Values: 500.1 504.6 518.8 524.6 525.3 6144.5 6182.2 6303.1 6344.6 6376.8 6211.5 6238.3 6254.2 6271.9 6310.7 5138.2 5161.4 5177.4 5205.6 5231.4 4848.4 5039.2 5041.3 5076.4 5163.5 4979.5 5005.0 5011.4 5053.0 5063.4 4946.1 4989.1 5000.2 5015.4 5022.5 4480.1 4515.6 4542.4 4569.9 4575.3 6156.8 6252.2 6276.3 6277.9 6305.4 5687.9 5700.6 5723.8 5724.0 5740.4 6572.4 6590.8 6610.8 6618.8 6657.6 4892.8 4932.9 4943.0 4953.2 4958.4 6815.6 6884.8 6933.8 6947.0 6964.4 4995.6 5025.8 5042.9 5047.4 5054.7 5077.4 5133.4 5136.6 5140.5 5143.0 5721.5 5724.3 5730.0 5744.3 5748.0 6367.8 6558.2 6666.8 6684.0 6709.7 1654.4 1720.9 1747.9 1750.5 1752.8 1213.0 1218.9 1222.5 1233.2 1239.1 5595.8 5650.3 5674.5 5711.2 5802.1 6585.8 6619.5 6655.3 6711.6 6792.6 5713.5 5734.3 5739.7 5826.8 5830.8 3562.9 3582.8 3590.3 3608.4 3609.2 6490.2 6507.8 6552.6 6569.4 6584.7 6756.8 6845.6 6860.6 6866.6 6895.6 6401.7 6499.2 6511.2 6515.8 6518.6 6562.8 6588.5 6602.4 6623.9 6643.9 6543.4 6646.3 6656.4 6656.8 6661.3 6394.1 6430.7 6466.7 6485.1 6503.4 4904.2 4955.7 4958.9 4985.7 4987.4 6422.3 6644.8 6761.3 6762.6 6830.7 6276.9 6495.2 6495.7 6543.4 6572.0 6412.2 6459.4 6471.3 6500.0 6523.5 6329.5 6344.9 6345.8 6383.7 6443.9 6202.7 6349.6 6443.1 6488.6 6567.3 6260.3 6330.5 6340.1 6353.0 6455.2 03:44:56 INFO - PID 3806 | 03:44:56 INFO - PID 3806 | [#5] yui.html Cycles:180 Average:24231.50 Median:20207.49 stddev:35301.71 (174.7%) stddev-sans-first:35357.32 03:44:56 INFO - PID 3806 | Values: 913.1 923.7 932.0 939.6 958.1 16631.7 17362.9 17409.4 17419.3 19342.7 20195.3 20230.0 20250.5 20304.8 20398.6 935.5 953.4 953.5 953.6 956.9 951.7 977.8 982.6 990.2 1000.5 1042.4 1045.0 1045.7 1046.5 1049.8 1027.5 1028.0 1028.3 1028.3 1028.8 756.2 757.4 758.1 758.4 759.0 18061.3 18454.8 18594.4 18635.2 18654.6 20862.2 20878.3 21226.7 21312.7 21357.1 16926.8 17212.9 17469.0 17507.6 17508.8 3798.9 3837.8 3841.1 3854.0 3857.5 137960.0 139326.0 139354.0 140621.0 141403.0 16824.2 17144.3 17311.8 17344.8 17353.7 31009.0 31787.4 31851.8 31883.5 31895.2 8219.4 8307.8 8316.2 8344.8 8415.2 3692.9 3943.2 3996.3 3996.8 4029.1 4178.7 6013.1 6162.1 6173.1 6194.0 1111.3 1144.4 1161.3 1162.3 1164.2 618.8 629.3 633.4 637.2 646.7 10904.7 11081.2 11272.4 11312.9 11999.9 614.8 616.4 616.4 628.8 635.2 5309.2 5325.6 5333.4 5352.7 5354.6 124472.0 125296.0 125410.4 125838.4 127198.0 105702.5 106768.7 109256.0 109477.5 111532.0 87915.0 88834.0 90510.5 93222.0 93468.0 9370.2 9757.0 9763.6 9773.2 9778.6 42654.6 43230.0 43951.8 44455.8 45916.8 56790.4 57118.7 57336.9 58503.0 59015.1 14349.8 14725.3 14820.5 14870.3 14960.3 16184.0 16413.0 16447.2 17327.4 20219.7 16567.8 16623.0 16786.9 16852.2 16890.3 16008.0 16100.6 16139.0 16267.8 16319.8 15582.8 15652.9 15792.3 15841.0 15931.6 12655.4 12675.6 12956.5 12981.3 13039.0 12155.9 12164.0 12225.3 12291.5 12337.1 03:44:56 INFO - PID 3806 | -------- Summary: end -------- 03:44:56 INFO - PID 3806 | 03:44:56 INFO - TEST-INFO | 3806: exit 0 03:44:56 INFO - TEST-OK | dromaeo_css | took 1111342ms 03:44:56 INFO - TEST-START | kraken 03:44:56 INFO - Initialising browser for kraken test... 03:44:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35567/getInfo.html -profile /tmp/tmpRapPFH/profile 03:44:56 INFO - TEST-INFO | started process 4177 (/builds/slave/test/build/application/firefox/firefox http://localhost:35567/getInfo.html) 03:45:03 INFO - TEST-INFO | 4177: exit 0 03:45:03 INFO - Browser initialized. 03:45:03 INFO - Running cycle 1/1 for kraken test... 03:45:03 INFO - Using env: {'DISPLAY': ':0', 03:45:03 INFO - 'HOME': '/home/cltbld', 03:45:03 INFO - 'JSGC_DISABLE_POISONING': '1', 03:45:03 INFO - 'LANG': 'en_US.UTF-8', 03:45:03 INFO - 'LANGUAGE': 'en_US:en', 03:45:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:45:03 INFO - 'LOGNAME': 'cltbld', 03:45:03 INFO - 'MAIL': '/var/mail/cltbld', 03:45:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:03 INFO - 'MOZ_CRASHREPORTER': '1', 03:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:45:03 INFO - 'MOZ_NO_REMOTE': '1', 03:45:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:03 INFO - 'NO_EM_RESTART': '1', 03:45:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:03 INFO - 'PWD': '/builds/slave/test', 03:45:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:03 INFO - 'RUST_BACKTRACE': 'full', 03:45:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:45:03 INFO - 'SHELL': '/bin/bash', 03:45:03 INFO - 'SHLVL': '1', 03:45:03 INFO - 'STYLO_FORCE_DISABLED': '1', 03:45:03 INFO - 'TERM': 'linux', 03:45:03 INFO - 'TMOUT': '86400', 03:45:03 INFO - 'USER': 'cltbld', 03:45:03 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359', 03:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:03 INFO - '_': '/tools/buildbot/bin/python'} 03:45:03 INFO - TEST-INFO | started process 4379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRapPFH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:04 INFO - PID 4379 | 03:45:04 INFO - PID 4379 | (/builds/slave/test/build/application/firefox/firefox:4430): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:04 INFO - PID 4379 | 03:45:14 INFO - PID 4379 | RSS: Main: 168796160 03:45:14 INFO - PID 4379 | 03:45:17 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35567/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:18 INFO - PID 4379 | RSS: Main: 173731840 03:45:18 INFO - PID 4379 | 03:45:20 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35567/tests/kraken/driver.html?testName=audio-dft) 03:45:21 INFO - PID 4379 | RSS: Main: 173678592 03:45:21 INFO - PID 4379 | 03:45:24 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35567/tests/kraken/driver.html?testName=audio-fft) 03:45:25 INFO - PID 4379 | RSS: Main: 169848832 03:45:25 INFO - PID 4379 | 03:45:27 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35567/tests/kraken/driver.html?testName=audio-oscillator) 03:45:27 INFO - PID 4379 | RSS: Main: 170303488 03:45:27 INFO - PID 4379 | 03:45:29 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:30 INFO - PID 4379 | RSS: Main: 170512384 03:45:30 INFO - PID 4379 | 03:45:33 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35567/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:34 INFO - PID 4379 | RSS: Main: 173023232 03:45:34 INFO - PID 4379 | 03:45:37 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35567/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:38 INFO - PID 4379 | RSS: Main: 173117440 03:45:38 INFO - PID 4379 | 03:45:41 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35567/tests/kraken/driver.html?testName=json-parse-financial) 03:45:42 INFO - PID 4379 | RSS: Main: 173670400 03:45:42 INFO - PID 4379 | 03:45:44 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:44 INFO - PID 4379 | RSS: Main: 173481984 03:45:44 INFO - PID 4379 | 03:45:45 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:46 INFO - PID 4379 | RSS: Main: 170184704 03:45:46 INFO - PID 4379 | 03:45:48 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:49 INFO - PID 4379 | RSS: Main: 170520576 03:45:49 INFO - PID 4379 | 03:45:52 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:53 INFO - PID 4379 | RSS: Main: 170930176 03:45:53 INFO - PID 4379 | 03:45:56 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:56 INFO - PID 4379 | RSS: Main: 170991616 03:45:56 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:35567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35567/tests/kraken/driver.html?testName=ai-astar) 03:45:58 INFO - PID 4379 | RSS: Main: 172646400 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | __start_tp_report 03:45:58 INFO - PID 4379 | _x_x_mozilla_page_load 03:45:58 INFO - PID 4379 | _x_x_mozilla_page_load_details 03:45:58 INFO - PID 4379 | |i|pagename|runs| 03:45:58 INFO - PID 4379 | |0;ai-astar;108;106;106;107;113;108;107;108;109;106 03:45:58 INFO - PID 4379 | |1;audio-beat-detection;122;117;121;116;115;120;140;118;124;119 03:45:58 INFO - PID 4379 | |2;audio-dft;164;167;162;161;164;164;163;166;164;166 03:45:58 INFO - PID 4379 | |3;audio-fft;74;74;75;75;74;73;74;76;75;73 03:45:58 INFO - PID 4379 | |4;audio-oscillator;80;79;79;79;83;79;80;78;87;79 03:45:58 INFO - PID 4379 | |5;imaging-gaussian-blur;110;113;109;114;113;114;113;113;110;114 03:45:58 INFO - PID 4379 | |6;imaging-darkroom;147;148;148;147;147;147;148;150;149;148 03:45:58 INFO - PID 4379 | |7;imaging-desaturate;94;93;94;94;94;94;96;94;95;94 03:45:58 INFO - PID 4379 | |8;json-parse-financial;54;54;53;54;56;52;53;52;57;60 03:45:58 INFO - PID 4379 | |9;json-stringify-tinderbox;38;38;38;38;38;43;38;38;38;38 03:45:58 INFO - PID 4379 | |10;stanford-crypto-aes;73;79;73;72;75;76;74;76;82;74 03:45:58 INFO - PID 4379 | |11;stanford-crypto-ccm;114;115;113;117;110;113;114;119;118;120 03:45:58 INFO - PID 4379 | |12;stanford-crypto-pbkdf2;173;171;168;167;169;174;170;187;167;167 03:45:58 INFO - PID 4379 | |13;stanford-crypto-sha256-iterative;66;64;75;64;69;67;66;66;66;64 03:45:58 INFO - PID 4379 | __end_tp_report 03:45:58 INFO - PID 4379 | __start_cc_report 03:45:58 INFO - PID 4379 | _x_x_mozilla_cycle_collect,924 03:45:58 INFO - PID 4379 | __end_cc_report 03:45:58 INFO - PID 4379 | __startTimestamp1505213158895__endTimestamp 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | ------- Summary: start ------- 03:45:58 INFO - PID 4379 | Number of tests: 14 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#0] ai-astar Cycles:10 Average:107.80 Median:108.00 stddev:2.10 (1.9%) stddev-sans-first:2.22 03:45:58 INFO - PID 4379 | Values: 108.0 106.0 106.0 107.0 113.0 108.0 107.0 108.0 109.0 106.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:120.50 stddev:7.16 (5.9%) stddev-sans-first:7.59 03:45:58 INFO - PID 4379 | Values: 122.0 117.0 121.0 116.0 115.0 120.0 140.0 118.0 124.0 119.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.85 (1.1%) stddev-sans-first:1.96 03:45:58 INFO - PID 4379 | Values: 164.0 167.0 162.0 161.0 164.0 164.0 163.0 166.0 164.0 166.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.50 stddev:0.95 (1.3%) stddev-sans-first:1.00 03:45:58 INFO - PID 4379 | Values: 74.0 74.0 75.0 75.0 74.0 73.0 74.0 76.0 75.0 73.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:79.50 stddev:2.71 (3.4%) stddev-sans-first:2.87 03:45:58 INFO - PID 4379 | Values: 80.0 79.0 79.0 79.0 83.0 79.0 80.0 78.0 87.0 79.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#5] imaging-gaussian-blur Cycles:10 Average:112.30 Median:113.00 stddev:1.89 (1.7%) stddev-sans-first:1.81 03:45:58 INFO - PID 4379 | Values: 110.0 113.0 109.0 114.0 113.0 114.0 113.0 113.0 110.0 114.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 03:45:58 INFO - PID 4379 | Values: 147.0 148.0 148.0 147.0 147.0 147.0 148.0 150.0 149.0 148.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:45:58 INFO - PID 4379 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 96.0 94.0 95.0 94.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.51 (4.6%) stddev-sans-first:2.65 03:45:58 INFO - PID 4379 | Values: 54.0 54.0 53.0 54.0 56.0 52.0 53.0 52.0 57.0 60.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:38.00 stddev:1.58 (4.2%) stddev-sans-first:1.67 03:45:58 INFO - PID 4379 | Values: 38.0 38.0 38.0 38.0 38.0 43.0 38.0 38.0 38.0 38.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:3.06 (4.1%) stddev-sans-first:3.12 03:45:58 INFO - PID 4379 | Values: 73.0 79.0 73.0 72.0 75.0 76.0 74.0 76.0 82.0 74.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:116.00 stddev:3.13 (2.7%) stddev-sans-first:3.28 03:45:58 INFO - PID 4379 | Values: 114.0 115.0 113.0 117.0 110.0 113.0 114.0 119.0 118.0 120.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:170.50 stddev:6.06 (3.6%) stddev-sans-first:6.39 03:45:58 INFO - PID 4379 | Values: 173.0 171.0 168.0 167.0 169.0 174.0 170.0 187.0 167.0 167.0 03:45:58 INFO - PID 4379 | 03:45:58 INFO - PID 4379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:3.30 (5.0%) stddev-sans-first:3.49 03:45:58 INFO - PID 4379 | Values: 66.0 64.0 75.0 64.0 69.0 67.0 66.0 66.0 66.0 64.0 03:45:58 INFO - PID 4379 | -------- Summary: end -------- 03:45:58 INFO - PID 4379 | 03:45:59 INFO - PID 4379 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:45:59 INFO - TEST-INFO | 4379: exit 0 03:45:59 INFO - TEST-OK | kraken | took 62707ms 03:45:59 INFO - SUITE-END | took 1174s 03:46:00 INFO - Completed test suite (00:19:34) 03:46:00 INFO - javascript benchmark 03:46:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8484.70344802733, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.514305282681, 3157.6368717597484, 3161.4625513662677, 3167.3981943430745, 3168.6356069052067, 6166.506679465643, 6220.284667263266, 6256.84357891053, 6333.08170315304, 6420.422162005424, 6264.436200741932, 6277.686115694209, 6295.0, 6299.527535434838, 6307.432331090201, 5810.418958104198, 5825.970870145665, 5875.88248235035, 5888.970555147218, 5902.940970590304, 5813.622114562561, 5832.533397328225, 5860.912086318709, 5861.472467477926, 5875.059990401536, 28.380593545861586, 5391.622586418933, 5665.688387138705, 5854.677992710399, 5912.142739302799, 5723.141528770676, 5729.255196824428, 5776.249087618583, 5795.536357091422, 5878.2064421303, 5759.1937128802, 5779.248697669318, 5847.502962248214, 5855.3851845556455, 5856.97071514644, 6269.153664255313, 6299.181106456177, 6317.589356691847, 6363.395477429637, 6370.076338930876, 6492.123563318986, 6726.0919775830125, 6734.326567343275, 6818.0, 6835.658217089126, 6720.49596280276, 6780.32196780318, 6837.247902730695, 6838.14523184602, 6839.931600683979, 6284.057391391282, 6289.685515724242, 6356.237251529799, 6369.93630063698, 6377.298497165308, 6898.655067246617, 6959.0, 6998.265182155902, 7014.0, 7041.155061392666, 6421.229452465641, 6508.9023664645065, 6523.608583485006, 6535.215774107042, 6563.146790917151, 6638.435732962752, 6683.565568238049, 6704.631245281459, 6801.809683305401, 6802.693878775467, 6727.327267273234, 6792.76225332111, 6801.353871382211, 6803.625800580917, 6811.080504131879, 6738.663066846638, 6757.087793147961, 6760.594364338155, 6849.0, 6858.5199036067, 5185.507376799198, 5251.868703282372, 5291.365036195682, 5348.0, 5353.2773075634295, 4579.107074120515, 4582.518835522289, 4643.233866412072, 4674.439067311876, 4752.881177970578, 5825.359210486843, 5870.882582348415, 5891.1457838614015, 5893.734781934823, 5895.204147440127, 6783.93216067833, 6796.830079248059, 6807.795766127024, 6873.0, 6894.96575513677, 5640.238567793377, 5773.971130144322, 5800.1299805029585, 5878.030125029322, 5902.468777810018, 5853.2976042875125, 5871.0, 5873.20711703923, 5887.2052272943465, 5888.823335299948, 6521.315261897433, 6528.347165283529, 6612.2726500084955, 6614.801555953329, 6619.867602648016, 6778.694958726771, 6784.185897692209, 6809.7276108956075, 6872.793816185523, 6878.518503704692, 6322.557420980487, 6436.710348034256, 6463.870722585616, 6479.222493300834, 6536.439139489131, 6569.113169722217, 6595.307492713388, 6656.567323123982, 6746.831329216612, 6754.223264324469, 6810.148731408574, 6821.761238356634, 6884.4148247397525, 6904.516683832084, 6915.03189553473, 6543.0185472179555, 6553.770618028537, 6618.106555614931, 6629.337066293525, 6635.900461493178, 6475.449586784987, 6541.149650545589, 6573.638449885302, 6613.503987200883, 6622.602643841385, 6522.510811689048, 6551.115599394021, 6558.049082883051, 6566.212054553484, 6567.080608714879, 6497.18785151856, 6502.349765023459, 6589.0, 6633.1045308882685, 6675.632840193836, 6248.281447633581, 6357.904631430625, 6386.616802991835, 6397.26431460388, 6404.263509696445], "value": 6115.672321375751, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.7374853172716, 846.437119315655, 868.9044205137434, 869.1395518436746, 871.3116637856094, 39168.60831391692, 41161.79419102904, 41904.37143442851, 41970.58029419705, 42718.57281427185, 42463.575364246346, 42772.57227427725, 42788.78605606968, 42862.35706464398, 42866.14267714644, 7727.2659097385795, 7857.960710196441, 7868.449208555404, 7870.606469676522, 7876.645550950221, 7755.49589276698, 7871.960640196819, 7876.724314648988, 7882.330001949841, 7889.289963903248, 7840.333571646417, 7875.0, 7879.212078792104, 7893.881591776128, 7898.80252993674, 7830.099538553054, 7869.449138560303, 7876.763697089096, 7878.369730421553, 7884.842303153933, 7692.115406728242, 7779.37764978806, 7780.066392032993, 7783.571903545303, 7784.182660820589, 37988.62011379906, 38082.809585951894, 38090.80954595237, 38176.23647527062, 38263.617363826284, 3492.057144570977, 3518.40187168182, 3531.6644918732677, 3532.947005794915, 3537.540119784437, 32084.839575801972, 32091.83954080238, 32125.0, 32132.83933580317, 32145.0, 5005.674631149, 5178.352705911761, 5211.557017653504, 5228.738563071869, 5230.450802665741, 175835.0, 178104.0, 178501.0, 178559.0, 178972.10513947476, 44631.55368446339, 44716.55283447189, 44748.552514475086, 44807.55192448099, 44826.77586612046, 46563.0, 46588.0, 46646.300305495446, 46658.30012549814, 46691.29963050557, 15690.058596484247, 15897.205139742966, 15902.840971590367, 15922.522324330288, 15964.840351596567, 13102.803457947948, 13114.213147211198, 13139.080264381593, 13160.078794484294, 13161.60515184546, 12181.451834667461, 12446.937765311297, 12501.937490312672, 12573.622791316275, 12631.242125472501, 5080.59355251579, 5087.287779710843, 5109.131447653907, 5173.301604283373, 5197.324347834758, 994.0755097759009, 998.9001099889953, 1000.4547521600745, 1003.5835128421623, 1018.2159737002466, 22331.88834055852, 22390.55218895613, 22513.774862251496, 22661.20685776023, 22688.65967010496, 1099.912007039435, 1114.9832752508719, 1121.5513794482272, 1127.8646562412564, 1129.0854407929603, 11907.345096019802, 11947.462364193632, 11984.700382490508, 12046.698832529257, 12074.456649450796, 209045.0, 209783.0, 210611.0, 243163.0, 248186.0, 58858.0, 59233.40766592279, 59265.0, 59331.40668593259, 59360.0, 1473.82314122306, 1475.365592795087, 1485.8439863814144, 1487.2340744516582, 1493.6489924867647, 27070.72929270682, 27411.451770964868, 27428.0, 27482.17553473399, 27706.861465692542, 36973.26053478969, 37152.25695486021, 37428.43857342088, 37428.81285593555, 37525.249495010496, 196503.0, 197598.0, 197641.0, 197878.0, 197992.0, 34397.82801085978, 34629.13427164341, 34790.0, 34854.12864678403, 35036.474452882714, 44424.77787611041, 44437.33343999907, 44452.33321500245, 44461.33308000447, 44888.0, 31303.261277021116, 31566.526502102945, 31795.364092717555, 31823.893099322268, 31891.6810831898, 31377.0, 31657.0, 31799.205019874687, 31947.68052319447, 32177.517337240428, 35956.28087438289, 35970.82014590015, 36017.63982360143, 36030.63969360273, 36207.275854482235, 30644.0, 30692.232694182825, 30778.230544236572, 31212.687873121886, 31503.0, 21956.451088722908, 22319.77241251747, 22436.66345004859, 22743.0, 22937.426564336027], "value": 17078.417522609834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2930672006634, 569.4447913284548, 575.2119596153266, 575.7840809696366, 587.691461982459, 22133.114675412984, 23013.309600711986, 23030.0, 23041.539169216605, 23061.654075188886, 23757.524849503043, 24169.39576510588, 24555.386115347126, 25353.49293014143, 25526.0, 6405.007223880294, 6480.060391243291, 6494.447971922392, 6505.967470162643, 6511.804645860631, 6435.131257280277, 6435.6138631682015, 6552.148220731298, 6558.147440832685, 6708.027336036272, 6626.2048554173325, 6673.799786006428, 6683.766068187614, 6689.431398331148, 6690.096836927001, 6232.0963460298, 6684.197896252432, 6688.197416310049, 6692.364225398628, 6701.329867013308, 6047.0627052806885, 6064.605800622945, 6065.60573562717, 6067.575269731121, 6067.939320606782, 28397.574036389266, 28846.0, 28881.277968050756, 28909.56635650467, 28941.42117157645, 2061.4228016155503, 2093.110428068065, 2098.9580208395746, 2100.9474763130893, 2102.2326850699383, 18538.907305463385, 19091.140898659592, 19249.13378897953, 19333.51666208356, 19588.118534665973, 2424.3454267347893, 2444.3500637070083, 2460.065175233418, 2485.3413845331, 2486.78862296705, 118494.40752796181, 124365.37817310856, 125044.0, 133351.33324333414, 141482.99999999898, 14852.0, 14864.925630405201, 14947.982022427052, 14980.550583482513, 15200.847991519944, 23152.884235578713, 23161.0, 23170.884145579163, 23221.419464513183, 23231.651525227135, 10048.09567138961, 10050.0, 10109.443980581138, 10110.69667909964, 10349.482525873676, 9260.21288190498, 9369.297302702325, 9378.906210937803, 9446.480443575532, 9475.76310592227, 8866.335024873031, 8892.110788921056, 8893.599788009555, 8897.644094236159, 9129.269658427309, 2567.717551069381, 2578.9226323210332, 2680.7185245548935, 2702.1083042595897, 2746.1761471558452, 940.9247260219166, 942.5004747483845, 955.7515046087929, 966.6133546581283, 969.4328817641758, 19491.22035118608, 19540.0, 19813.900930495543, 19819.027145928227, 20109.09509072095, 1038.6520515627349, 1045.5608644369383, 1052.7999680060764, 1058.8358804385332, 1066.8879767624444, 10971.23201375896, 10973.231873768918, 10993.890061099286, 11012.724681882857, 11091.500882460146, 472944.0, 473616.0, 482853.0, 487962.0, 496530.0, 109178.45410773055, 112118.0, 113023.0, 113658.0, 114604.0, 1137.7496950671004, 1152.654203738875, 1176.4294317256124, 1185.2829038431796, 1189.102227817992, 17281.56796080108, 17398.913005434893, 17520.561985950455, 18011.5497112568, 18094.5476363092, 56439.43560564506, 57414.7129264351, 57906.0, 58467.4153258479, 60410.69794650999, 67870.0, 68652.656736718, 71947.28052719406, 72108.0, 72679.27320726936, 14389.64025899319, 14672.0, 14699.674150070678, 14781.334839932013, 14806.555803325917, 22757.43106422353, 22880.54238915179, 22957.540849183257, 23109.653355200022, 23138.421539461648, 17990.0, 18070.186841592422, 18560.814391855907, 18570.25718971226, 18595.44213673592, 15504.457343993357, 15869.841301586835, 16759.0, 16814.747778783574, 16870.746938796172, 18525.53686157857, 18542.44372668822, 18579.0, 18607.162677679265, 18708.345207917657, 14351.928240358731, 14460.855391446372, 14468.421263149356, 14505.419783208554, 14523.273836308354, 17641.82358176402, 17736.467905962843, 17814.91092544581, 17815.198316075548, 18015.459536213933], "value": 11892.652510823073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1173.3312012153071, 1253.3670496399318, 1256.3529782162186, 1364.8398860968173, 1410.6614412540994, 15529.378824847006, 15964.680706385865, 15978.600534986632, 16017.919910400446, 16020.59948501288, 15616.921915390436, 15742.29159687814, 15743.448979285728, 15750.054996700206, 15772.290246938886, 2782.6939036705944, 2829.8868045278164, 2848.145556333102, 2863.584780206869, 2874.6694130174983, 2764.226016715323, 2796.8881244750187, 2799.762020228283, 2800.3979144483933, 2812.8312301261885, 2772.88908443662, 2864.8281103133772, 2866.3693987322754, 2866.4410439964113, 2872.8707208175683, 2791.330080780618, 2799.300174956261, 2814.845183514906, 2820.703826098251, 2825.8163219390776, 2756.8759405826786, 2776.4585905748386, 2787.637607111083, 2794.9441011179865, 2797.4125433658955, 14947.626309342244, 15286.847131528653, 15294.388224471008, 15294.847051529454, 15295.388184472607, 8033.0, 8341.290990265834, 8348.290395316406, 8352.498850068954, 8361.83276334476, 5280.2079688046715, 5406.0, 5472.7263636818, 5511.063119269694, 5568.916466253009, 1890.1305399516239, 1926.9807301926942, 1940.5827747034314, 1973.3586584359996, 2002.499375156211, 26464.0737574184, 26699.332516687045, 26711.866440667865, 26801.463970720477, 26843.0, 6588.571742836701, 6698.229703584053, 6862.794116176523, 6907.689153988083, 7053.0830991970715, 17255.74116388255, 17260.309587616604, 17271.3955011574, 17286.22212000463, 17286.913565432344, 7929.405294602928, 8093.676252949816, 8098.028236611644, 8099.716509922242, 8100.0, 7428.071491063617, 7443.702251909863, 7471.4396420268695, 7476.476646634684, 7502.3622992046285, 5165.715885626327, 5337.226102215157, 5343.19852022192, 5362.785488580491, 5391.406945236021, 1359.9796003059962, 1399.1605036977733, 1546.5746919596975, 1554.7901033360579, 1575.763635454691, 894.3471265975744, 904.6381447420953, 919.4253591505309, 920.7375897869075, 927.8329900617819, 7606.847863042708, 7612.8477430451085, 7657.655405506765, 7724.266194711493, 7736.458447908705, 992.5235886774389, 999.9750006249902, 1001.234055947201, 1007.7631756537207, 1007.8992100789862, 4534.886627834265, 4653.395058642355, 4677.976610116928, 4708.693934894221, 4756.762161891892, 21421.89289053576, 21623.891880540497, 22149.889250553642, 22178.667319990214, 22310.219142330265, 21294.893525532272, 21422.250221242495, 21819.90900454971, 22019.0, 22024.779752202274, 11379.0, 11493.827592586118, 11519.0, 11565.248258863146, 11568.421578921188, 7646.847063058819, 7851.332636725942, 7914.24814642608, 7946.602669866599, 7984.401169912164, 18374.08129593542, 18819.153138109094, 18966.241350346383, 19105.331313403964, 19170.137343819282, 19510.512237194183, 19575.80424195797, 19756.11097500587, 19785.802141978395, 19912.402627921187, 10711.94644026775, 10740.4092774895, 10839.349639021368, 10844.18668599874, 10916.235863489479, 12986.480540778262, 13070.607881763563, 13108.737825243252, 13120.868791312347, 13153.408096635865, 11173.664790056311, 11235.101191904465, 11329.830052549054, 11402.600908968478, 11477.94261028723, 11068.39123848164, 11123.888761112285, 11134.443277835913, 11245.325280483197, 11407.600733974272, 9537.093976072261, 9695.466749328854, 9702.708918732167, 9704.417734935927, 9706.369086009669, 6879.071325371011, 6880.58716477013, 6892.0, 6911.654417279216, 6924.723011079501, 6817.625030623363, 6817.89773153413, 6858.794236172923, 6933.965330173317, 6934.895976560457], "value": 6681.68360180879, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.09482836066724, 504.5685938522563, 518.846940152655, 524.5908191610542, 525.3287035424864, 6144.494598823283, 6182.165407669963, 6303.14907487489, 6344.572471193979, 6376.808695739123, 6211.453304145301, 6238.344973777756, 6254.21822272216, 6271.874562508759, 6310.684465776704, 5138.229265610151, 5161.380634323877, 5177.378714554259, 5205.635605507616, 5231.372235331746, 4848.418189817226, 5039.244113383003, 5041.294218809369, 5076.375559820859, 5163.535281824635, 4979.502049795028, 5004.9729859407, 5011.448740638527, 5052.9747351263195, 5063.392392912837, 4946.1344264753525, 4989.05645669057, 5000.224965130411, 5015.423226328982, 5022.497750224985, 4480.103979204172, 4515.61617262533, 4542.38677778499, 4569.9314510282375, 4575.313702944552, 6156.84607884802, 6252.218472690914, 6276.278228003793, 6277.937220627781, 6305.432511074026, 5687.914681279784, 5700.572457065737, 5723.771049158028, 5723.971380143114, 5740.368559458456, 6572.37562431573, 6590.835229119262, 6610.834729131762, 6618.801435956929, 6657.600543967329, 4892.75536223191, 4932.8520144395725, 4943.0, 4953.2168419369, 4958.429780575244, 6815.591064536144, 6884.793456196322, 6933.757318493828, 6947.027416161742, 6964.408025317804, 4995.575376093, 5025.79896804131, 5042.949570504248, 5047.419546752097, 5054.711048682562, 5077.365329333833, 5133.435322114565, 5136.640435169502, 5140.46025167352, 5142.9742851286255, 5721.485066344049, 5724.255846739898, 5730.025895597759, 5744.310682718101, 5748.0, 6367.840803979845, 6558.213014438298, 6666.83332916681, 6684.0, 6709.731610735614, 1654.4374912529797, 1720.8623310135158, 1747.9126043697763, 1750.5011071844717, 1752.772139621841, 1212.9757404851853, 1218.8842060004285, 1222.462116668663, 1233.23647184527, 1239.0954603139758, 5595.776168953196, 5650.29371328584, 5674.546036317085, 5711.200431939532, 5802.071668533014, 6585.805884146185, 6619.470442364599, 6655.267920528738, 6711.563748356341, 6792.626405547742, 5713.457221563945, 5734.254546908875, 5739.741711622987, 5826.766144789598, 5830.76676932918, 3562.91092722684, 3582.829196161416, 3590.281943611288, 3608.386574282378, 3609.205974685565, 6490.188726409199, 6507.772227972093, 6552.57408268461, 6569.408753212138, 6584.7366105356205, 6756.844540607589, 6845.623490707959, 6860.588364698134, 6866.622335771581, 6895.586264824126, 6401.743930242738, 6499.237823924813, 6511.186101737283, 6515.771947981798, 6518.57629254097, 6562.80311590653, 6588.472922166119, 6602.438792702674, 6623.933760662332, 6643.867122657616, 6543.378379053982, 6646.344510519291, 6656.434203092597, 6656.76701315471, 6661.300563440769, 6394.136791533084, 6430.742770289323, 6466.736642175201, 6485.092087107903, 6503.447206987459, 4904.239842824368, 4955.677880937727, 4958.8760280993265, 4985.725785081855, 4987.351644286219, 6422.2614399344675, 6644.800655980328, 6761.256261811099, 6762.628055456997, 6830.726770929107, 6276.874462510816, 6495.1556297681, 6495.675216239264, 6543.411093001652, 6571.98134289186, 6412.23053233615, 6459.418652321314, 6471.255805582418, 6499.967500162658, 6523.499595093061, 6329.5252856036905, 6344.936550634619, 6345.841353966188, 6383.6808159592765, 6443.903341449975, 6202.689865506797, 6349.618633273531, 6443.09796628463, 6488.578242414228, 6567.343265673395, 6260.311365749672, 6330.461910737455, 6340.112384266298, 6353.0, 6455.160829092188], "value": 5065.393339320162, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.0686699566438, 923.6674797073053, 932.0120672087584, 939.5912777941596, 958.0754571838177, 16631.667366652673, 17362.91318543407, 17409.390671326506, 17419.303227870885, 19342.709859352122, 20195.293164739236, 20230.0, 20250.493737656565, 20304.796952030476, 20398.592028159426, 935.4854829843609, 953.41365060488, 953.4994128082777, 953.613786416499, 956.9473678947655, 951.6954574536152, 977.8337682593976, 982.5873133284002, 990.1633120013577, 1000.4997501249376, 1042.4318746283257, 1045.033344156652, 1045.6549338718205, 1046.4924511611862, 1049.7690508088247, 1027.4965267019106, 1027.964021259256, 1028.3007554862727, 1028.331584470093, 1028.8302430099025, 756.2248695087525, 757.4281417529785, 758.0713625808396, 758.3516093739828, 759.0398146344878, 18061.27754889803, 18454.815451845578, 18594.442166735018, 18635.161417736097, 18654.626907461912, 20862.16551337945, 20878.269260575806, 21226.681599776017, 21312.680309795367, 21357.145714171413, 16926.83073169277, 17212.91393543037, 17469.0, 17507.5623109422, 17508.824911750973, 3798.867039653599, 3837.827297771607, 3841.135744457503, 3854.036490877281, 3857.4599556062176, 137960.0, 139326.0, 139354.0, 140621.0, 141403.0, 16824.15879206035, 17144.314227431012, 17311.826881731275, 17344.82655173432, 17353.65292694139, 31009.0, 31787.364252715277, 31851.84074079615, 31883.52174717381, 31895.202619934687, 8219.424640275243, 8307.8338433231, 8316.168383161636, 8344.8331033379, 8415.200555947175, 3692.9076773080888, 3943.2310699413338, 3996.320625493673, 3996.8201430935096, 4029.073313137995, 4178.7283826551175, 6013.128096425994, 6162.137300777895, 6173.104899789595, 6194.0, 1111.2721167635211, 1144.4449442020614, 1161.3380373187372, 1162.273579013117, 1164.1967042740482, 618.7865186510646, 629.3266205160526, 633.3792882974618, 637.2066776862742, 646.6637348578713, 10904.672859814218, 11081.168912331608, 11272.380019098864, 11312.94343528277, 11999.940000300117, 614.846288427893, 616.4082480818375, 616.4451993206061, 628.7987843889912, 635.2345423764353, 5309.150535914235, 5325.600579956519, 5333.413324534298, 5352.732363381815, 5354.625176237626, 124472.0, 125296.0, 125410.3729481365, 125838.37080814537, 127198.0, 105702.4714876436, 106768.7497815013, 109256.0, 109477.45261273642, 111532.0, 87915.0, 88834.0, 90510.54744726235, 93222.0, 93468.0, 9370.15668589803, 9756.951215243878, 9763.609455621696, 9773.169280611228, 9778.559964801743, 42654.57345426506, 43230.0, 43951.78024109987, 44455.77772111119, 45916.77041614771, 56790.432095678516, 57118.71440642936, 57336.85326293534, 58503.0, 59015.114773279296, 14349.784753228501, 14725.337359819048, 14820.48128315547, 14870.256487175815, 14960.251987400805, 16184.0, 16413.0, 16447.177641118134, 17327.393541225996, 20219.69670454915, 16567.834321656628, 16623.0, 16786.916065420082, 16852.15739213059, 16890.324387024873, 16008.0, 16100.597485062966, 16139.0, 16267.837321627107, 16319.755203671717, 15582.844171558592, 15652.92173539125, 15792.289346979183, 15841.0, 15931.601709957344, 12655.430505627453, 12675.556355527513, 12956.481740730642, 12981.286029268482, 13039.0, 12155.878441215475, 12164.026877849928, 12225.327606981346, 12291.50833966667, 12337.074719395901], "value": 8874.110758363619, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 107.0, 113.0, 108.0, 107.0, 108.0, 109.0, 106.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 121.0, 116.0, 115.0, 120.0, 140.0, 118.0, 124.0, 119.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 162.0, 161.0, 164.0, 164.0, 163.0, 166.0, 164.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 74.0, 73.0, 74.0, 76.0, 75.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 83.0, 79.0, 80.0, 78.0, 87.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 109.0, 114.0, 113.0, 114.0, 113.0, 113.0, 110.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 150.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 56.0, 52.0, 53.0, 52.0, 57.0, 60.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 43.0, 38.0, 38.0, 38.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 73.0, 72.0, 75.0, 76.0, 74.0, 76.0, 82.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 117.0, 110.0, 113.0, 114.0, 119.0, 118.0, 120.0], "value": 115.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 168.0, 167.0, 169.0, 174.0, 170.0, 187.0, 167.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 75.0, 64.0, 69.0, 67.0, 66.0, 66.0, 66.0, 64.0], "value": 66.7, "unit": "score"}]}]} 03:46:00 INFO - Return code: 0 03:46:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:00 INFO - # TBPL SUCCESS # 03:46:00 INFO - Running post-action listener: _package_coverage_data 03:46:00 INFO - Running post-action listener: _resource_record_post_action 03:46:00 INFO - [mozharness: 2017-09-12 10:46:00.180764Z] Finished run-tests step (success) 03:46:00 INFO - Running post-run listener: _resource_record_post_run 03:46:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9052160; Write bytes: 416960512; Read time: 2908; Write time: 325572 03:46:00 INFO - TinderboxPrint: CPU usage
13.1% 03:46:00 INFO - TinderboxPrint: I/O read bytes / time
9,052,160 / 2,908 03:46:00 INFO - TinderboxPrint: I/O write bytes / time
416,960,512 / 325,572 03:46:00 INFO - TinderboxPrint: CPU idle
8,247.5 (86.8%) 03:46:00 INFO - TinderboxPrint: CPU user
1,191.5 (12.5%) 03:46:00 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 552960; Read time: 0; Write time: 48 03:46:00 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:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 7507968; Write bytes: 416407552; Read time: 2868; Write time: 325524 03:46:00 INFO - Running post-run listener: _upload_blobber_files 03:46:00 INFO - Blob upload gear active. 03:46:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:00 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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:02 INFO - (blobuploader) - INFO - Done attempting. 03:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:06 INFO - (blobuploader) - INFO - Done attempting. 03:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:07 INFO - (blobuploader) - INFO - Done attempting. 03:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:08 INFO - (blobuploader) - INFO - Done attempting. 03:46:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:08 INFO - Return code: 0 03:46:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad447f175d5b53adf3b8e8236f80054bdda565336301d8b6bd214cf6d2198e89bf9f59fb08657929488d3397d16176f39ec719e190098fc2c89ff65ad498b0ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/549576eebf1bcf720894b4c2591180381a66bf8f0a90a7ae0a6ad95b349806b1d3aab867aa398467a99cfcb709519bfeb846a22025e5e92da0eeb61e631e927a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2303c104347538fea4ec77b40611aacecddeb8c126045af97bbe1a37bee0aa68c2f6229f234252fafd3b740fa6922e1a5313a5e2dc050951335175a92ba3a1bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/481cd5e676e5895c7123e6bdb8be0bb82fe167cd4e1fb92ee43e4c2b63b3f50369e1dd6ccf52bd32a5ac649426bc2ff45df1cb7c547700b63accc5e6c541f8eb"} 03:46:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:08 INFO - Contents: 03:46:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad447f175d5b53adf3b8e8236f80054bdda565336301d8b6bd214cf6d2198e89bf9f59fb08657929488d3397d16176f39ec719e190098fc2c89ff65ad498b0ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/549576eebf1bcf720894b4c2591180381a66bf8f0a90a7ae0a6ad95b349806b1d3aab867aa398467a99cfcb709519bfeb846a22025e5e92da0eeb61e631e927a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2303c104347538fea4ec77b40611aacecddeb8c126045af97bbe1a37bee0aa68c2f6229f234252fafd3b740fa6922e1a5313a5e2dc050951335175a92ba3a1bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/481cd5e676e5895c7123e6bdb8be0bb82fe167cd4e1fb92ee43e4c2b63b3f50369e1dd6ccf52bd32a5ac649426bc2ff45df1cb7c547700b63accc5e6c541f8eb"} 03:46:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:08 INFO - Copying logs to upload dir... 03:46:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.823728 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-12 03:46:08.274810) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:08.278932) ========= 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=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad447f175d5b53adf3b8e8236f80054bdda565336301d8b6bd214cf6d2198e89bf9f59fb08657929488d3397d16176f39ec719e190098fc2c89ff65ad498b0ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/549576eebf1bcf720894b4c2591180381a66bf8f0a90a7ae0a6ad95b349806b1d3aab867aa398467a99cfcb709519bfeb846a22025e5e92da0eeb61e631e927a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2303c104347538fea4ec77b40611aacecddeb8c126045af97bbe1a37bee0aa68c2f6229f234252fafd3b740fa6922e1a5313a5e2dc050951335175a92ba3a1bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/481cd5e676e5895c7123e6bdb8be0bb82fe167cd4e1fb92ee43e4c2b63b3f50369e1dd6ccf52bd32a5ac649426bc2ff45df1cb7c547700b63accc5e6c541f8eb"} 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.011056 build_url: 'https://queue.taskcluster.net/v1/task/c8J8p6RuRZ-xxUSm_NtOkg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad447f175d5b53adf3b8e8236f80054bdda565336301d8b6bd214cf6d2198e89bf9f59fb08657929488d3397d16176f39ec719e190098fc2c89ff65ad498b0ff", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/549576eebf1bcf720894b4c2591180381a66bf8f0a90a7ae0a6ad95b349806b1d3aab867aa398467a99cfcb709519bfeb846a22025e5e92da0eeb61e631e927a", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2303c104347538fea4ec77b40611aacecddeb8c126045af97bbe1a37bee0aa68c2f6229f234252fafd3b740fa6922e1a5313a5e2dc050951335175a92ba3a1bd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/481cd5e676e5895c7123e6bdb8be0bb82fe167cd4e1fb92ee43e4c2b63b3f50369e1dd6ccf52bd32a5ac649426bc2ff45df1cb7c547700b63accc5e6c541f8eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:08.309596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:08.309951) ========= 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=9bfb7e13875ed353a705960e000001c0-1505210356.120412-571771359 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:46:08.389425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:08.389738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:46:08.390023) ========= ========= Total master_lag: 0.22 =========