builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-067 starttime: 1505431225.96 results: success (0) revision: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:25.955418) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:25.955802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:25.956080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.304988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.305286) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 16:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2017-09-14 16:20:26 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183959 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.587854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.588137) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052860 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.682211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:26.682513) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe --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 b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe --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=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 16:20:26,930 truncating revision to first 12 chars 2017-09-14 16:20:26,930 Setting DEBUG logging. 2017-09-14 16:20:26,930 attempt 1/10 2017-09-14 16:20:26,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b778b6cb49c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 16:20:27,189 unpacking tar archive at: mozilla-central-b778b6cb49c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:27.299602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:27.300002) ========= script_repo_revision: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:27.300417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:27.300742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 16:20:27.314375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-14 16:20:27.314675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:20:27 INFO - MultiFileLogger online at 20170914 16:20:27 in /builds/slave/test 16:20:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:27 INFO - {'append_to_log': False, 16:20:27 INFO - 'base_work_dir': '/builds/slave/test', 16:20:27 INFO - 'blob_upload_branch': 'Firefox', 16:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:27 INFO - 'branch': 'Firefox', 16:20:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:27 INFO - 'code_coverage': False, 16:20:27 INFO - 'config_files': ('talos/linux_config.py',), 16:20:27 INFO - 'default_actions': ('clobber', 16:20:27 INFO - 'read-buildbot-config', 16:20:27 INFO - 'download-and-extract', 16:20:27 INFO - 'populate-webroot', 16:20:27 INFO - 'create-virtualenv', 16:20:27 INFO - 'install', 16:20:27 INFO - 'setup-mitmproxy', 16:20:27 INFO - 'run-tests'), 16:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:27 INFO - 'disable_ccov_upload': False, 16:20:27 INFO - 'disable_stylo': False, 16:20:27 INFO - 'download_minidump_stackwalk': True, 16:20:27 INFO - 'download_symbols': 'ondemand', 16:20:27 INFO - 'enable_stylo': False, 16:20:27 INFO - 'enable_webrender': False, 16:20:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:27 INFO - 'gecko_profile': False, 16:20:27 INFO - 'gecko_profile_interval': 0, 16:20:27 INFO - 'installer_path': 'installer.exe', 16:20:27 INFO - 'log_level': 'info', 16:20:27 INFO - 'log_name': 'talos', 16:20:27 INFO - 'log_to_console': True, 16:20:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:20:27 INFO - 'opt_config_files': (), 16:20:27 INFO - 'pip_index': False, 16:20:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:20:27 INFO - 'system_bits': '32', 16:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:27 INFO - 'title': 'talos-linux64-ix-067', 16:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:27 INFO - 'use_talos_json': True, 16:20:27 INFO - 'verify': 'False', 16:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:27 INFO - 'work_dir': 'build'} 16:20:27 INFO - [mozharness: 2017-09-14 23:20:27.820931Z] Running clobber step. 16:20:27 INFO - Running pre-action listener: _resource_record_pre_action 16:20:27 INFO - Running main action method: clobber 16:20:27 INFO - rmtree: /builds/slave/test/build 16:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:29 INFO - Running post-action listener: _resource_record_post_action 16:20:29 INFO - [mozharness: 2017-09-14 23:20:29.694737Z] Finished clobber step (success) 16:20:29 INFO - [mozharness: 2017-09-14 23:20:29.694834Z] Running read-buildbot-config step. 16:20:29 INFO - Running pre-action listener: _resource_record_pre_action 16:20:29 INFO - Running main action method: read_buildbot_config 16:20:29 INFO - Using buildbot properties: 16:20:29 INFO - { 16:20:29 INFO - "project": "", 16:20:29 INFO - "product": "firefox", 16:20:29 INFO - "who": "archaeopteryx@coole-files.de", 16:20:29 INFO - "installer_path": "public/build/target.tar.bz2", 16:20:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:20:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:20:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:20:29 INFO - "stage_platform": "linux64-pgo", 16:20:29 INFO - "basedir": "/builds/slave/test", 16:20:29 INFO - "buildnumber": 17, 16:20:29 INFO - "platform": "ubuntu64_hw", 16:20:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:20:29 INFO - "slavebuilddir": "test", 16:20:29 INFO - "taskId": "fhXTzovpR7WnPQP5klzHVw", 16:20:29 INFO - "branch": "mozilla-central", 16:20:29 INFO - "script_repo_revision": "production", 16:20:29 INFO - "revision": "b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe", 16:20:29 INFO - "slavename": "talos-linux64-ix-067", 16:20:29 INFO - "repo_path": "mozilla-central" 16:20:29 INFO - } 16:20:29 INFO - Finding installer, test and symbols from parent task. 16:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhXTzovpR7WnPQP5klzHVw'}, attempt #1 16:20:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhXTzovpR7WnPQP5klzHVw'}, attempt #1 16:20:30 INFO - Task dependencies: fuFTFkSSSyONOOWatZLNWQ 16:20:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ'}, attempt #1 16:20:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 16:20:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.test_packages.json 16:20:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.crashreporter-symbols.zip 16:20:31 INFO - Running post-action listener: _resource_record_post_action 16:20:31 INFO - [mozharness: 2017-09-14 23:20:31.056865Z] Finished read-buildbot-config step (success) 16:20:31 INFO - [mozharness: 2017-09-14 23:20:31.057175Z] Running download-and-extract step. 16:20:31 INFO - Running pre-action listener: _resource_record_pre_action 16:20:31 INFO - Running main action method: download_and_extract 16:20:31 INFO - mkdir: /builds/slave/test/build/tests 16:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:31 INFO - trying https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.test_packages.json 16:20:31 INFO - Downloading https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:20:31 INFO - Downloaded 989 bytes. 16:20:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:20:31 INFO - Using the following test package requirements: 16:20:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:20:31 INFO - u'common': [u'target.common.tests.zip'], 16:20:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:20:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:20:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:20:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:20:31 INFO - u'mozbase': [u'target.common.tests.zip'], 16:20:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:20:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:20:31 INFO - u'web-platform': [u'target.common.tests.zip', 16:20:31 INFO - u'target.web-platform.tests.tar.gz'], 16:20:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:20:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:20:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.common.tests.zip 16:20:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:20:31 INFO - Fetch https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.common.tests.zip into memory 16:20:33 INFO - Content-Length response header: 55193802 16:20:33 INFO - Bytes received: 55193802 16:20:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.talos.tests.zip 16:20:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:20:45 INFO - Fetch https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.talos.tests.zip into memory 16:20:45 INFO - Content-Length response header: 14500356 16:20:45 INFO - Bytes received: 14500356 16:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:46 INFO - trying https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 16:20:46 INFO - Downloading https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:20:48 INFO - Downloaded 62280281 bytes. 16:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 16:20:48 INFO - mkdir: /builds/slave/test/properties 16:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:20:48 INFO - Writing to file /builds/slave/test/properties/build_url 16:20:48 INFO - Contents: 16:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 16:20:48 INFO - Running post-action listener: _resource_record_post_action 16:20:48 INFO - Running post-action listener: find_tests_for_verification 16:20:48 INFO - Running post-action listener: set_extra_try_arguments 16:20:48 INFO - [mozharness: 2017-09-14 23:20:48.046120Z] Finished download-and-extract step (success) 16:20:48 INFO - [mozharness: 2017-09-14 23:20:48.046283Z] Running populate-webroot step. 16:20:48 INFO - Running pre-action listener: _resource_record_pre_action 16:20:48 INFO - Running main action method: populate_webroot 16:20:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:20:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['tresize', 16:20:48 INFO - 'tcanvasmark']}, 16:20:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:20:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['dromaeo_css', 16:20:48 INFO - 'kraken']}, 16:20:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'tests': ['damp', 'tps']}, 16:20:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['damp', 'tps']}, 16:20:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:20:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['dromaeo_dom']}, 16:20:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:20:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['basic_compositor_video', 16:20:48 INFO - 'glvideo']}, 16:20:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:20:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['ts_paint_webext', 16:20:48 INFO - 'tp5o_webext']}, 16:20:48 INFO - 'other-e10s': {'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_many_windows', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_many_windows', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:20:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:20:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['bloom_basic_singleton']}, 16:20:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['bloom_basic']}, 16:20:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:20:48 INFO - 'tsvgr_opacity', 16:20:48 INFO - 'tart', 16:20:48 INFO - 'tscrollx', 16:20:48 INFO - 'tsvg_static']}, 16:20:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['tsvgx', 16:20:48 INFO - 'tsvgr_opacity', 16:20:48 INFO - 'tart', 16:20:48 INFO - 'tscrollx', 16:20:48 INFO - 'tsvg_static']}, 16:20:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:20:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo'], 16:20:48 INFO - 'tests': ['tp5o']}, 16:20:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:48 INFO - 'talos_options': ['--mitmproxy', 16:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:48 INFO - '--firstNonBlankPaint'], 16:20:48 INFO - 'tests': ['tp6_google', 16:20:48 INFO - 'tp6_youtube', 16:20:48 INFO - 'tp6_amazon', 16:20:48 INFO - 'tp6_facebook']}, 16:20:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo', 16:20:48 INFO - '--mitmproxy', 16:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:48 INFO - '--firstNonBlankPaint'], 16:20:48 INFO - 'tests': ['tp6_google', 16:20:48 INFO - 'tp6_youtube', 16:20:48 INFO - 'tp6_amazon', 16:20:48 INFO - 'tp6_facebook']}, 16:20:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:48 INFO - 'talos_options': ['--stylo-threads=1', 16:20:48 INFO - '--mitmproxy', 16:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:48 INFO - '--firstNonBlankPaint'], 16:20:48 INFO - 'tests': ['tp6_google', 16:20:48 INFO - 'tp6_youtube', 16:20:48 INFO - 'tp6_amazon', 16:20:48 INFO - 'tp6_facebook']}, 16:20:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--xperf_path', 16:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:48 INFO - 'tests': ['tp5n']}, 16:20:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-stylo', 16:20:48 INFO - '--xperf_path', 16:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:48 INFO - 'tests': ['tp5n']}}} 16:20:48 INFO - Running post-action listener: _resource_record_post_action 16:20:48 INFO - [mozharness: 2017-09-14 23:20:48.063274Z] Finished populate-webroot step (success) 16:20:48 INFO - [mozharness: 2017-09-14 23:20:48.063364Z] Running create-virtualenv step. 16:20:48 INFO - Running pre-action listener: _resource_record_pre_action 16:20:48 INFO - Running main action method: create_virtualenv 16:20:48 INFO - Creating virtualenv /builds/slave/test/build/venv 16:20:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:20:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:20:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:20:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:20:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:20:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:20:49 INFO - Installing pip...............done. 16:20:49 INFO - Return code: 0 16:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:20:49 INFO - Reading from file tmpfile_stdout 16:20:49 INFO - Output received: 16:20:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:20:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:20: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')]} 16:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20: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')]} 16:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20: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', 'pip>=1.5'] in /builds/slave/test/build 16:20: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 pip>=1.5 16:20:49 INFO - Using env: {'DISPLAY': ':0', 16:20:49 INFO - 'HOME': '/home/cltbld', 16:20:49 INFO - 'LANG': 'en_US.UTF-8', 16:20:49 INFO - 'LANGUAGE': 'en_US:en', 16:20:49 INFO - 'LOGNAME': 'cltbld', 16:20:49 INFO - 'MAIL': '/var/mail/cltbld', 16:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:49 INFO - 'MOZ_NO_REMOTE': '1', 16:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:49 INFO - 'NO_EM_RESTART': '1', 16:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:49 INFO - 'PWD': '/builds/slave/test', 16:20:49 INFO - 'SHELL': '/bin/bash', 16:20:49 INFO - 'SHLVL': '1', 16:20:49 INFO - 'TERM': 'linux', 16:20:49 INFO - 'TMOUT': '86400', 16:20:49 INFO - 'USER': 'cltbld', 16:20:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:49 INFO - '_': '/tools/buildbot/bin/python'} 16:20:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:20:50 INFO - Downloading/unpacking pip>=1.5 16:20:50 INFO - Running setup.py egg_info for package pip 16:20:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:20:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:20:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:20:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:20:50 INFO - Installing collected packages: pip 16:20:50 INFO - Found existing installation: pip 1.1 16:20:50 INFO - Uninstalling pip: 16:20:50 INFO - Successfully uninstalled pip 16:20:50 INFO - Running setup.py install for pip 16:20:50 INFO - warning: no files found matching 'pip/cacert.pem' 16:20:50 INFO - warning: no files found matching '*.html' under directory 'docs' 16:20:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:20:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:20:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:20:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:20:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:20:50 INFO - Successfully installed pip 16:20:50 INFO - Cleaning up... 16:20:50 INFO - Return code: 0 16:20:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:50 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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:20:50 INFO - Using env: {'DISPLAY': ':0', 16:20:50 INFO - 'HOME': '/home/cltbld', 16:20:50 INFO - 'LANG': 'en_US.UTF-8', 16:20:50 INFO - 'LANGUAGE': 'en_US:en', 16:20:50 INFO - 'LOGNAME': 'cltbld', 16:20:50 INFO - 'MAIL': '/var/mail/cltbld', 16:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:50 INFO - 'MOZ_NO_REMOTE': '1', 16:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:50 INFO - 'NO_EM_RESTART': '1', 16:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:50 INFO - 'PWD': '/builds/slave/test', 16:20:50 INFO - 'SHELL': '/bin/bash', 16:20:50 INFO - 'SHLVL': '1', 16:20:50 INFO - 'TERM': 'linux', 16:20:50 INFO - 'TMOUT': '86400', 16:20:50 INFO - 'USER': 'cltbld', 16:20:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:50 INFO - '_': '/tools/buildbot/bin/python'} 16:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:51 INFO - Downloading/unpacking psutil>=3.1.1 16:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:20:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:52 INFO - Installing collected packages: psutil 16:20:52 INFO - Running setup.py install for psutil 16:20:52 INFO - building 'psutil._psutil_linux' extension 16:20:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:20:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:20:53 INFO - building 'psutil._psutil_posix' extension 16:20:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:20:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:54 INFO - Successfully installed psutil 16:20:54 INFO - Cleaning up... 16:20:54 INFO - Return code: 0 16:20:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:20: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')]} 16:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20: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')]} 16:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:20: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 mozsystemmonitor==0.3 16:20:54 INFO - Using env: {'DISPLAY': ':0', 16:20:54 INFO - 'HOME': '/home/cltbld', 16:20:54 INFO - 'LANG': 'en_US.UTF-8', 16:20:54 INFO - 'LANGUAGE': 'en_US:en', 16:20:54 INFO - 'LOGNAME': 'cltbld', 16:20:54 INFO - 'MAIL': '/var/mail/cltbld', 16:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:54 INFO - 'MOZ_NO_REMOTE': '1', 16:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:54 INFO - 'NO_EM_RESTART': '1', 16:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:54 INFO - 'PWD': '/builds/slave/test', 16:20:54 INFO - 'SHELL': '/bin/bash', 16:20:54 INFO - 'SHLVL': '1', 16:20:54 INFO - 'TERM': 'linux', 16:20:54 INFO - 'TMOUT': '86400', 16:20:54 INFO - 'USER': 'cltbld', 16:20:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:54 INFO - '_': '/tools/buildbot/bin/python'} 16:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:20: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 16:20: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 16:20: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 16:20: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 16:20:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:20:55 INFO - Installing collected packages: mozsystemmonitor 16:20:55 INFO - Running setup.py install for mozsystemmonitor 16:20:55 INFO - Successfully installed mozsystemmonitor 16:20:55 INFO - Cleaning up... 16:20:55 INFO - Return code: 0 16:20:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:20:55 INFO - Using env: {'DISPLAY': ':0', 16:20:55 INFO - 'HOME': '/home/cltbld', 16:20:55 INFO - 'LANG': 'en_US.UTF-8', 16:20:55 INFO - 'LANGUAGE': 'en_US:en', 16:20:55 INFO - 'LOGNAME': 'cltbld', 16:20:55 INFO - 'MAIL': '/var/mail/cltbld', 16:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:55 INFO - 'MOZ_NO_REMOTE': '1', 16:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:55 INFO - 'NO_EM_RESTART': '1', 16:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:55 INFO - 'PWD': '/builds/slave/test', 16:20:55 INFO - 'SHELL': '/bin/bash', 16:20:55 INFO - 'SHLVL': '1', 16:20:55 INFO - 'TERM': 'linux', 16:20:55 INFO - 'TMOUT': '86400', 16:20:55 INFO - 'USER': 'cltbld', 16:20:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:55 INFO - '_': '/tools/buildbot/bin/python'} 16:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:55 INFO - Downloading/unpacking jsonschema==2.5.1 16:20: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 16:20: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 16:20: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 16:20: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 16:20:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:20:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:20: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 16:20: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 16:20: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 16:20: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 16:20:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:20:57 INFO - warning: no files found matching '*.txt' 16:20:57 INFO - no previously-included directories found matching 'build' 16:20:57 INFO - no previously-included directories found matching 'dist' 16:20:57 INFO - no previously-included directories found matching '.git*' 16:20:57 INFO - Installing collected packages: jsonschema, functools32 16:20:57 INFO - Running setup.py install for functools32 16:20:57 INFO - warning: no files found matching '*.txt' 16:20:57 INFO - no previously-included directories found matching 'build' 16:20:57 INFO - no previously-included directories found matching 'dist' 16:20:57 INFO - no previously-included directories found matching '.git*' 16:20:57 INFO - Successfully installed jsonschema functools32 16:20:57 INFO - Cleaning up... 16:20:57 INFO - Return code: 0 16:20:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:20:57 INFO - Using env: {'DISPLAY': ':0', 16:20:57 INFO - 'HOME': '/home/cltbld', 16:20:57 INFO - 'LANG': 'en_US.UTF-8', 16:20:57 INFO - 'LANGUAGE': 'en_US:en', 16:20:57 INFO - 'LOGNAME': 'cltbld', 16:20:57 INFO - 'MAIL': '/var/mail/cltbld', 16:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:57 INFO - 'MOZ_NO_REMOTE': '1', 16:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:57 INFO - 'NO_EM_RESTART': '1', 16:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:57 INFO - 'PWD': '/builds/slave/test', 16:20:57 INFO - 'SHELL': '/bin/bash', 16:20:57 INFO - 'SHLVL': '1', 16:20:57 INFO - 'TERM': 'linux', 16:20:57 INFO - 'TMOUT': '86400', 16:20:57 INFO - 'USER': 'cltbld', 16:20:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:57 INFO - '_': '/tools/buildbot/bin/python'} 16:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:20:57 INFO - Cleaning up... 16:20:57 INFO - Return code: 0 16:20:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:20:57 INFO - Using env: {'DISPLAY': ':0', 16:20:57 INFO - 'HOME': '/home/cltbld', 16:20:57 INFO - 'LANG': 'en_US.UTF-8', 16:20:57 INFO - 'LANGUAGE': 'en_US:en', 16:20:57 INFO - 'LOGNAME': 'cltbld', 16:20:57 INFO - 'MAIL': '/var/mail/cltbld', 16:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:57 INFO - 'MOZ_NO_REMOTE': '1', 16:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:57 INFO - 'NO_EM_RESTART': '1', 16:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:57 INFO - 'PWD': '/builds/slave/test', 16:20:57 INFO - 'SHELL': '/bin/bash', 16:20:57 INFO - 'SHLVL': '1', 16:20:57 INFO - 'TERM': 'linux', 16:20:57 INFO - 'TMOUT': '86400', 16:20:57 INFO - 'USER': 'cltbld', 16:20:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:57 INFO - '_': '/tools/buildbot/bin/python'} 16:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20: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 16:20: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 16:20: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 16:20: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 16:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - Downloading docopt-0.6.1.tar.gz 16:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:59 INFO - Running setup.py install for blobuploader 16:20:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:59 INFO - Running setup.py install for requests 16:20:59 INFO - Running setup.py install for docopt 16:21:00 INFO - Successfully installed blobuploader requests docopt 16:21:00 INFO - Cleaning up... 16:21:00 INFO - Return code: 0 16:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:00 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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:00 INFO - Using env: {'DISPLAY': ':0', 16:21:00 INFO - 'HOME': '/home/cltbld', 16:21:00 INFO - 'LANG': 'en_US.UTF-8', 16:21:00 INFO - 'LANGUAGE': 'en_US:en', 16:21:00 INFO - 'LOGNAME': 'cltbld', 16:21:00 INFO - 'MAIL': '/var/mail/cltbld', 16:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:00 INFO - 'MOZ_NO_REMOTE': '1', 16:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:00 INFO - 'NO_EM_RESTART': '1', 16:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:00 INFO - 'PWD': '/builds/slave/test', 16:21:00 INFO - 'SHELL': '/bin/bash', 16:21:00 INFO - 'SHLVL': '1', 16:21:00 INFO - 'TERM': 'linux', 16:21:00 INFO - 'TMOUT': '86400', 16:21:00 INFO - 'USER': 'cltbld', 16:21:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:00 INFO - '_': '/tools/buildbot/bin/python'} 16:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:00 INFO - Running setup.py (path:/tmp/pip-N7EVk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:00 INFO - Running setup.py (path:/tmp/pip-D79GzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:00 INFO - Running setup.py (path:/tmp/pip-11RYOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:00 INFO - Running setup.py (path:/tmp/pip-xD_rE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:00 INFO - Running setup.py (path:/tmp/pip-Dg6JMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:00 INFO - Running setup.py (path:/tmp/pip-pnn8rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:00 INFO - Running setup.py (path:/tmp/pip-vWWo5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:00 INFO - Running setup.py (path:/tmp/pip-SrYYGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:00 INFO - Running setup.py (path:/tmp/pip-nRcMeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:00 INFO - Running setup.py (path:/tmp/pip-5nGrNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:00 INFO - Running setup.py (path:/tmp/pip-1UVrD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:01 INFO - Running setup.py (path:/tmp/pip-5vKIqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:01 INFO - Running setup.py (path:/tmp/pip-Ja5Ol7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:01 INFO - Running setup.py (path:/tmp/pip-N5JVHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:01 INFO - Running setup.py (path:/tmp/pip-DMz0Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:01 INFO - Running setup.py (path:/tmp/pip-Ahmnb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:01 INFO - Running setup.py (path:/tmp/pip-xwJwPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:01 INFO - Running setup.py install for manifestparser 16:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:01 INFO - Running setup.py install for mozcrash 16:21:01 INFO - Running setup.py install for mozdebug 16:21:01 INFO - Running setup.py install for mozdevice 16:21:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:01 INFO - Running setup.py install for mozfile 16:21:01 INFO - Running setup.py install for mozhttpd 16:21:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozinfo 16:21:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozInstall 16:21:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozleak 16:21:02 INFO - Running setup.py install for mozlog 16:21:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for moznetwork 16:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozprocess 16:21:02 INFO - Running setup.py install for mozprofile 16:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozrunner 16:21:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozscreenshot 16:21:03 INFO - Running setup.py install for moztest 16:21:03 INFO - Running setup.py install for mozversion 16:21:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:03 INFO - Cleaning up... 16:21:03 INFO - Return code: 0 16:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:03 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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:03 INFO - Using env: {'DISPLAY': ':0', 16:21:03 INFO - 'HOME': '/home/cltbld', 16:21:03 INFO - 'LANG': 'en_US.UTF-8', 16:21:03 INFO - 'LANGUAGE': 'en_US:en', 16:21:03 INFO - 'LOGNAME': 'cltbld', 16:21:03 INFO - 'MAIL': '/var/mail/cltbld', 16:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:03 INFO - 'MOZ_NO_REMOTE': '1', 16:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:03 INFO - 'NO_EM_RESTART': '1', 16:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:03 INFO - 'PWD': '/builds/slave/test', 16:21:03 INFO - 'SHELL': '/bin/bash', 16:21:03 INFO - 'SHLVL': '1', 16:21:03 INFO - 'TERM': 'linux', 16:21:03 INFO - 'TMOUT': '86400', 16:21:03 INFO - 'USER': 'cltbld', 16:21:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:03 INFO - '_': '/tools/buildbot/bin/python'} 16:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Running setup.py (path:/tmp/pip-3gxf01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 INFO - Running setup.py (path:/tmp/pip-K4MOse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Running setup.py (path:/tmp/pip-9TC2C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 INFO - Running setup.py (path:/tmp/pip-WMzDCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Running setup.py (path:/tmp/pip-U5feI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:03 INFO - Running setup.py (path:/tmp/pip-oO327Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:03 INFO - Running setup.py (path:/tmp/pip-ZdGjSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21: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)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:03 INFO - Running setup.py (path:/tmp/pip-Frj9ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:04 INFO - Running setup.py (path:/tmp/pip-kF96cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:04 INFO - Running setup.py (path:/tmp/pip-OyuubS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:04 INFO - Running setup.py (path:/tmp/pip-aZYjuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:04 INFO - Running setup.py (path:/tmp/pip-8JlObY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 INFO - Running setup.py (path:/tmp/pip-w1TREw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Running setup.py (path:/tmp/pip-LvMZRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Running setup.py (path:/tmp/pip-kAAT84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Running setup.py (path:/tmp/pip-dUcFGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Running setup.py (path:/tmp/pip-Ca0KEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:21:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:05 INFO - Downloading blessings-1.6.tar.gz 16:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:05 INFO - Installing collected packages: blessings 16:21:05 INFO - Running setup.py install for blessings 16:21:06 INFO - Successfully installed blessings 16:21:06 INFO - Cleaning up... 16:21:06 INFO - Return code: 0 16:21:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:06 INFO - Reading from file tmpfile_stdout 16:21:06 INFO - Current package versions: 16:21:06 INFO - argparse == 1.2.1 16:21:06 INFO - blessings == 1.6 16:21:06 INFO - blobuploader == 1.2.4 16:21:06 INFO - docopt == 0.6.1 16:21:06 INFO - functools32 == 3.2.3-2 16:21:06 INFO - jsonschema == 2.5.1 16:21:06 INFO - manifestparser == 1.1 16:21:06 INFO - mozInstall == 1.13 16:21:06 INFO - mozcrash == 1.0 16:21:06 INFO - mozdebug == 0.1 16:21:06 INFO - mozdevice == 0.51 16:21:06 INFO - mozfile == 1.2 16:21:06 INFO - mozhttpd == 0.7 16:21:06 INFO - mozinfo == 0.10 16:21:06 INFO - mozleak == 0.1 16:21:06 INFO - mozlog == 3.5 16:21:06 INFO - moznetwork == 0.27 16:21:06 INFO - mozprocess == 0.25 16:21:06 INFO - mozprofile == 0.28 16:21:06 INFO - mozrunner == 6.13 16:21:06 INFO - mozscreenshot == 0.1 16:21:06 INFO - mozsystemmonitor == 0.3 16:21:06 INFO - moztest == 0.8 16:21:06 INFO - mozversion == 1.4 16:21:06 INFO - psutil == 3.1.1 16:21:06 INFO - requests == 1.2.3 16:21:06 INFO - wsgiref == 0.1.2 16:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:06 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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:21:06 INFO - Using env: {'DISPLAY': ':0', 16:21:06 INFO - 'HOME': '/home/cltbld', 16:21:06 INFO - 'LANG': 'en_US.UTF-8', 16:21:06 INFO - 'LANGUAGE': 'en_US:en', 16:21:06 INFO - 'LOGNAME': 'cltbld', 16:21:06 INFO - 'MAIL': '/var/mail/cltbld', 16:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:06 INFO - 'MOZ_NO_REMOTE': '1', 16:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:06 INFO - 'NO_EM_RESTART': '1', 16:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:06 INFO - 'PWD': '/builds/slave/test', 16:21:06 INFO - 'SHELL': '/bin/bash', 16:21:06 INFO - 'SHLVL': '1', 16:21:06 INFO - 'TERM': 'linux', 16:21:06 INFO - 'TMOUT': '86400', 16:21:06 INFO - 'USER': 'cltbld', 16:21:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:06 INFO - '_': '/tools/buildbot/bin/python'} 16:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:21:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:21:07 INFO - Installing collected packages: simplejson 16:21:07 INFO - Running setup.py install for simplejson 16:21:07 INFO - building 'simplejson._speedups' extension 16:21: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 16:21:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:21:08 INFO - Successfully installed simplejson 16:21:08 INFO - Cleaning up... 16:21:08 INFO - Return code: 0 16:21:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:08 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 0x19721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:21:08 INFO - Using env: {'DISPLAY': ':0', 16:21:08 INFO - 'HOME': '/home/cltbld', 16:21:08 INFO - 'LANG': 'en_US.UTF-8', 16:21:08 INFO - 'LANGUAGE': 'en_US:en', 16:21:08 INFO - 'LOGNAME': 'cltbld', 16:21:08 INFO - 'MAIL': '/var/mail/cltbld', 16:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:08 INFO - 'MOZ_NO_REMOTE': '1', 16:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:08 INFO - 'NO_EM_RESTART': '1', 16:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:08 INFO - 'PWD': '/builds/slave/test', 16:21:08 INFO - 'SHELL': '/bin/bash', 16:21:08 INFO - 'SHLVL': '1', 16:21:08 INFO - 'TERM': 'linux', 16:21:08 INFO - 'TMOUT': '86400', 16:21:08 INFO - 'USER': 'cltbld', 16:21:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:08 INFO - '_': '/tools/buildbot/bin/python'} 16:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:21:08 INFO - Cleaning up... 16:21:08 INFO - Return code: 0 16:21:08 INFO - Running post-action listener: _resource_record_post_action 16:21:08 INFO - Running post-action listener: _start_resource_monitoring 16:21:08 INFO - Starting resource monitoring. 16:21:08 INFO - [mozharness: 2017-09-14 23:21:08.987331Z] Finished create-virtualenv step (success) 16:21:08 INFO - [mozharness: 2017-09-14 23:21:08.988341Z] Running install step. 16:21:08 INFO - Running pre-action listener: _resource_record_pre_action 16:21:08 INFO - Running main action method: install 16:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:09 INFO - Reading from file tmpfile_stdout 16:21:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:09 INFO - Reading from file tmpfile_stdout 16:21:09 INFO - Output received: 16:21:09 INFO - Usage: mozinstall [options] installer 16:21:09 INFO - Options: 16:21:09 INFO - -h, --help show this help message and exit 16:21:09 INFO - -d DEST, --destination=DEST 16:21:09 INFO - Directory to install application into. [default: 16:21:09 INFO - "/builds/slave/test"] 16:21:09 INFO - --app=APP Application being installed. [default: firefox] 16:21:09 INFO - mkdir: /builds/slave/test/build/application 16:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:21:26 INFO - Reading from file tmpfile_stdout 16:21:26 INFO - Output received: 16:21:26 INFO - /builds/slave/test/build/application/firefox/firefox 16:21:26 INFO - Running post-action listener: _resource_record_post_action 16:21:26 INFO - [mozharness: 2017-09-14 23:21:26.936130Z] Finished install step (success) 16:21:26 INFO - [mozharness: 2017-09-14 23:21:26.936382Z] Running setup-mitmproxy step. 16:21:26 INFO - Running pre-action listener: _resource_record_pre_action 16:21:26 INFO - Running main action method: setup_mitmproxy 16:21:26 INFO - Skipping: mitmproxy is not required 16:21:26 INFO - Running post-action listener: _resource_record_post_action 16:21:26 INFO - [mozharness: 2017-09-14 23:21:26.937499Z] Finished setup-mitmproxy step (success) 16:21:26 INFO - [mozharness: 2017-09-14 23:21:26.937719Z] Running run-tests step. 16:21:26 INFO - Running pre-action listener: _resource_record_pre_action 16:21:26 INFO - Running pre-action listener: _set_gcov_prefix 16:21:26 INFO - Running main action method: run_tests 16:21:26 WARNING - Try message not found. 16:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:26 INFO - Python 2.7.3 16:21:26 INFO - Return code: 0 16:21:26 INFO - grabbing minidump binary from tooltool 16:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:26 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 0x1ce2090>, '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 0x1ce2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:21:26 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:21:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:27 INFO - Return code: 0 16:21:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: RUST_BACKTRACE is now full 16:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:21:27 INFO - Using env: {'DISPLAY': ':0', 16:21:27 INFO - 'HOME': '/home/cltbld', 16:21:27 INFO - 'LANG': 'en_US.UTF-8', 16:21:27 INFO - 'LANGUAGE': 'en_US:en', 16:21:27 INFO - 'LOGNAME': 'cltbld', 16:21:27 INFO - 'MAIL': '/var/mail/cltbld', 16:21:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:27 INFO - 'MOZ_NO_REMOTE': '1', 16:21:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:27 INFO - 'NO_EM_RESTART': '1', 16:21:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:27 INFO - 'PWD': '/builds/slave/test', 16:21:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:27 INFO - 'RUST_BACKTRACE': 'full', 16:21:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:21:27 INFO - 'SHELL': '/bin/bash', 16:21:27 INFO - 'SHLVL': '1', 16:21:27 INFO - 'TERM': 'linux', 16:21:27 INFO - 'TMOUT': '86400', 16:21:27 INFO - 'USER': 'cltbld', 16:21:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:27 INFO - '_': '/tools/buildbot/bin/python'} 16:21:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:21:27 INFO - mozversion application_buildid: 20170914215707 16:21:27 INFO - mozversion application_changeset: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe 16:21:27 INFO - mozversion application_display_name: Nightly 16:21:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:27 INFO - mozversion application_name: Firefox 16:21:27 INFO - mozversion application_remotingname: firefox 16:21:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:21:27 INFO - mozversion application_vendor: Mozilla 16:21:27 INFO - mozversion application_version: 57.0a1 16:21:27 INFO - mozversion platform_buildid: 20170914215707 16:21:27 INFO - mozversion platform_changeset: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe 16:21:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:21:27 INFO - mozversion platform_version: 57.0a1 16:21:27 INFO - using testdate: 1505431287 16:21:27 INFO - actual date: 1505431287 16:21:27 INFO - starting webserver on 'localhost:48978' 16:21:27 INFO - SUITE-START | Running 2 tests 16:21:27 INFO - TEST-START | dromaeo_css 16:21:27 INFO - Initialising browser for dromaeo_css test... 16:21:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48978/getInfo.html -profile /tmp/tmp9TKXex/profile 16:21:27 INFO - TEST-INFO | started process 3595 (/builds/slave/test/build/application/firefox/firefox http://localhost:48978/getInfo.html) 16:21:34 INFO - TEST-INFO | 3595: exit 0 16:21:34 INFO - Browser initialized. 16:21:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:21:34 INFO - Using env: {'DISPLAY': ':0', 16:21:34 INFO - 'HOME': '/home/cltbld', 16:21:34 INFO - 'JSGC_DISABLE_POISONING': '1', 16:21:34 INFO - 'LANG': 'en_US.UTF-8', 16:21:34 INFO - 'LANGUAGE': 'en_US:en', 16:21:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:21:34 INFO - 'LOGNAME': 'cltbld', 16:21:34 INFO - 'MAIL': '/var/mail/cltbld', 16:21:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:34 INFO - 'MOZ_CRASHREPORTER': '1', 16:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:21:34 INFO - 'MOZ_NO_REMOTE': '1', 16:21:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:34 INFO - 'NO_EM_RESTART': '1', 16:21:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:34 INFO - 'PWD': '/builds/slave/test', 16:21:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:34 INFO - 'RUST_BACKTRACE': 'full', 16:21:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:21:34 INFO - 'SHELL': '/bin/bash', 16:21:34 INFO - 'SHLVL': '1', 16:21:34 INFO - 'STYLO_FORCE_DISABLED': '1', 16:21:34 INFO - 'TERM': 'linux', 16:21:34 INFO - 'TMOUT': '86400', 16:21:34 INFO - 'USER': 'cltbld', 16:21:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:34 INFO - '_': '/tools/buildbot/bin/python'} 16:21:34 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9TKXex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:35 INFO - PID 3819 | 16:21:35 INFO - PID 3819 | (/builds/slave/test/build/application/firefox/firefox:3869): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:21:35 INFO - PID 3819 | 16:21:45 INFO - PID 3819 | RSS: Main: 166715392 16:21:45 INFO - PID 3819 | 16:24:43 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48978/tests/dromaeo/cssquery-ext.html) 16:24:44 INFO - PID 3819 | RSS: Main: 170254336 16:24:44 INFO - PID 3819 | 16:27:45 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-ext.html (next: http://localhost:48978/tests/dromaeo/cssquery-jquery.html) 16:27:46 INFO - PID 3819 | RSS: Main: 165367808 16:27:46 INFO - PID 3819 | 16:30:47 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48978/tests/dromaeo/cssquery-mootools.html) 16:30:48 INFO - PID 3819 | RSS: Main: 168808448 16:30:48 INFO - PID 3819 | 16:33:49 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48978/tests/dromaeo/cssquery-prototype.html) 16:33:50 INFO - PID 3819 | RSS: Main: 166633472 16:33:50 INFO - PID 3819 | 16:36:53 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48978/tests/dromaeo/cssquery-yui.html) 16:36:54 INFO - PID 3819 | RSS: Main: 169226240 16:36:54 INFO - PID 3819 | 16:39:55 INFO - PID 3819 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-yui.html (next: http://localhost:48978/tests/dromaeo/cssquery-dojo.html) 16:39:56 INFO - PID 3819 | RSS: Main: 170688512 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | __start_tp_report 16:39:56 INFO - PID 3819 | _x_x_mozilla_page_load 16:39:56 INFO - PID 3819 | _x_x_mozilla_page_load_details 16:39:56 INFO - PID 3819 | |i|pagename|runs| 16:39:56 INFO - PID 3819 | |0;dojo.html;3795.5824859265476;3830.8850734477974;3859.2474467478837;3864.0339915021245;3886.378179491282;6082.118092876531;6225.657588832612;6265.874682506347;6287.1198032275515;6304.59020163689;6198.938010619892;6252.499800015999;6272.9372706272925;6291.0563415487695;6386.2975072741965;5527.861803454925;5567.916481252784;5568.470995255444;5626.324841019084;5645.943540564583;665.2652405094593;5582.525485333752;5642.407547207546;5701.600887937846;5708;5553.222548843165;5596.776128954837;5602.355729091166;5687.033204355249;5688.857778555528;5571.609987300891;5575.470330318613;5641.746121424505;5652.349979752299;5665.291838520185;5569.860753481195;5586.636868603528;5588.888222235532;5650.886982260373;5661.433856614347;6203.596766210227;6257.968710156466;6263.561550691454;6289.591176573508;6291.43377096059;6725.630090345029;6748.898766518457;6813.6593170341785;6823;6824.112865327475;6660.733570657168;6721.126253587051;6731.461483081342;6743.393094621508;6774.153230846145;6223.253209614875;6246.25044994599;6246.312905580383;6249.343818898996;6251.156093927352;6885.758998435031;6905.827354316082;6914.861702765917;7021.543599666005;7031.753888613874;6707.899381509281;6715.56348837324;6794.932050679528;6804.047433359334;6812.48906332027;6817.284185160586;6819.522633415613;6876.071730316443;6900.930990690129;6908.827279317957;6606.306337834554;6677.399034086956;6696.799096027127;6755.088063111515;6797.592144471348;6741.561798483083;6789.694463749143;6797.694103765342;6821.4542836572955;6824.6928888200155;4956.925646115311;4960.652754307236;5017.9247311290355;5026.271190677331;5034.697918124924;4439.689221754511;4491.708038977521;4500.167469018242;4513.751743654065;4532.818687252539;6128.1114238435175;6158.7228574714245;6160.353162917919;6160.722767475474;6238.625682459067;6722.058911752359;6796.388325050769;6825.385715285549;6825.69284382204;6844.657767111724;6121.357257487989;6163.96918015407;6178.165947597017;6223.284322302993;6238.75044998195;5417.18742188667;5418.539424148991;5430.5384042356845;5469.753861076261;5508.008558459515;7083.787486375417;7134.500584959107;7136.357727804522;7137.286271372821;7139.428845692332;6540.607563546202;6691.933080669131;6710.127683401127;6750.257471678112;6843.349881761224;6942.618156001468;6947.409470194888;7082.4688148390105;7120.181179164462;7137.072180616487;6700.497462690415;6703.530752847254;6776.085228494288;6779.288174741779;6791.796246112624;6778.8983165251575;6781.38967492928;6839.247682754993;6841.042254084333;6841.315868413119;6498.902516462352;6536.444402225864;6566.277709452052;6571.934280657132;6596.538242322991;6483.351664833667;6492;6573.506986976092;6574.8356291093105;6579.80260592183;6435.51733619971;6439.098526206429;6441.967790161019;6530.346965303432;6545.247296560957;6447.2263328400895;6490.123833282447;6508.511861610304;6555.934440655723;6596.472282217315;6214.9067763982675;6267.185265915402;6319.46284565817;6367.9044814328745;6368.458681011981 16:39:56 INFO - PID 3819 | |1;ext.html;951.2485136741974;961.1301771896436;985.0592683986794;1008.838585826268;1012.9544170512327;45327.546724532745;45899.770501147446;45939;46172.769136154275;46178.3073253901;45906;46271.76864115683;46355.768221158934;46419.76790116045;46444.53555464453;8200.30297424718;8317.168283171664;8334.083250842403;8342.582870856464;8355.206255405727;8137.186281371874;8259.587020648974;8271.710490132846;8314.376421768362;8322.500649960992;8334.166583341648;8363.581820908961;8384;8386.245237928586;8397.748067557952;8268.214519620626;8287.461315014534;8307.044689860622;8325.125861784516;8326.292265157468;8107.108218096005;8163.959180204061;8164.428490005702;8178.345732341458;8181.509109453393;42054.579454205676;42372.78813605912;42383;42453.78773106146;42461.1507769846;3728.3102626014274;3770.0386401467727;3771.1326394929047;3772.264408440355;3772.773633581994;34118.48822267668;34256.82871585651;34308.82845585781;34420.48369274463;34465.310693785985;5361.571074314045;5424.321959755031;5435.918461223085;5466.863328416782;5522.22688823565;215610;216490.99999999843;216749;217228;218204;52197;52202.21696674477;52234;52341.7382913083;52469;54047.45952540503;54308.728456357465;54493.72753136209;54506.727466363205;54641.726791366586;16717.331306747838;16925.91537042307;16926.322947082226;16932.32270709158;16958.321667133176;13731.588052358446;13789.241591712553;13805.585832425044;13806.17162970225;13808.516701915585;13840.723185536233;14129.940254480955;14134.717305653829;14167.362468688934;14303.284835758379;5275.57795376369;5319.973400132974;5350.839474815684;5387.542058924957;5474.069408200616;1074.258761454594;1076.39721755817;1082.1937656445998;1086.7554800169898;1097.2045267181388;25796.74203257981;26057.869710651325;26240.60639090415;26389.868050659625;26539.867300663373;1174.8942595166477;1182.645206438065;1193.0574845871838;1195.5636192789568;1198.5205917632843;13810.585682429542;13814.993651840854;13815.309234538232;13951;14144.222067786164;257442;258231;258709;285890;287987;61899.07151392733;62028;62082.37917620856;62096.68951655303;62157.37842621606;1482.9110253384831;1486.620911667518;1490.7838363437459;1507.1108046252543;1514.4547962733627;30825.38349232958;31000;31080.110166447277;31191.376172476877;31320.53019204668;37073.814630926674;41649;41809;41885.162296754504;42104.57895421007;217665;218226;218394;219197;219581;36772.44841327329;36797.26405471929;37034.25931481301;37117.62882371142;37184;47302.52697473119;47600.761996189794;47887.76056119697;48314.75842620764;48464;35590.64409355873;35820.64179358173;35883.82058089693;35940.46089308715;36170.63829361673;35753.927382178575;35935;35938;35949.64050359568;36166.63833361738;42545.93635159146;42584.5741542593;42784;43034.56965430306;43152.35271470993;34335.313293734485;34993;35322.47016294809;35479.82260088683;35875.64124358723;25698.35754106162;25960.091396801778;26009.349766255236;26045.470667871774;26459.470810583294 16:39:56 INFO - PID 3819 | |2;jquery.html;588.7497813429294;596.2487266044785;598.1386803003671;600.3576173494362;625.2684359299618;23072.538549229026;23998.400039999007;24094.75905240947;24187.395315117108;24201.75798242017;24037.75962240377;26218.606720899203;26348.736512634867;26385;26405.471890562178;6743.258241593433;6800.761973330935;6830.692618832164;6831.658417079151;6848.075509806162;6632.900506492407;6873.656317184146;6874.587524748506;6884.449244060464;6894.172699276094;6820.829479263009;6839.384455399013;6857.27998560149;6862.862742745167;6875.862482750342;6595.53831231814;6817.386435220805;6819.5908245505425;6832.316768323153;6847.383735463832;6366.108744775735;6379.425851673325;6386.776462823779;6389.361063893573;6407.615543067384;29129.70870291291;29728.256793580116;29769.553456698166;29791.55312670312;29818.254543636365;2150.440885369815;2160.7407111146763;2186.584548935697;2188.365374041526;2191.6712493126;18968.14643341053;20110.39668809938;20180.596388072303;20320.390388288375;20328;2545.338212064858;2578.742125787425;2620.331815387064;2636.9604455933177;2638.2085374387607;136303.31848340793;142675;142757;144627.276863615;150624;15457.227138643248;15680.76478852818;16166.515004549883;16188.919055404647;16483.527470879464;25113;25152.24543263705;25164;25222.117225897007;25362.11232606887;10170.186385089175;10328.431936243429;10439.217058720626;10481.239600457662;10510.737231569272;9316.975132735393;9391.107844754737;9429.717108486619;9555.569999350046;9623.518824058769;9560.90439095614;9626.95186524063;9925.2059835213;9971.950140249397;9982.303008488574;2887.6246088008425;2944.8527573621664;2955.6453225613063;2962.792604517663;3000.729934305923;1028.665683652816;1034.6844212515105;1047.9318844275251;1060.5320601632773;1082.43172334525;20693.793062069188;20746.170153194005;20802;20906.581868362853;21154.365369038955;1094.3433939636154;1106.2975010868156;1110.5724296146043;1111.2776695148057;1124.5389390349917;10985.39580323074;11105.722356941142;11169.664910052712;11287.604933827277;11410.543578256777;593592;610150;617346;617747;619714;118041;120602;120662.396688016;121776;123300;1215.5745489078752;1226.2336039975016;1262.2931158551241;1264.4310060472824;1269;17862.642747145244;18028.729569056213;18110.54723631867;18410.72383914269;18562.81437185665;60324.39675603188;60765.392346075976;61277.08084378827;61310.693446534264;62158;74729.2527074744;75043.24956750362;75168.24831751832;76145.85781213397;76334;14759.409623615365;14993.17537535446;15012.624684382978;15032.774508382601;15097;22938.42653933665;22995.770042299362;23091;23257.53484930258;23325.76674233236;18854.905725471286;19041.238350465825;19155.90422047881;19227.327043553407;19467.318643847397;14603.196824174773;15715.842841571895;16453.177341132658;16577.585560360603;17241.22414491376;19094.61810763805;19378.224871005565;19416.90291548533;19528.21887124556;19966.30117945865;14842.18367989771;14885.479008234659;14906.925465372604;14970.47603333878;15047.699046019237;18675;18993.240270389582;19004.23983040663;19178.13698383604;19364.322248721226 16:39:56 INFO - PID 3819 | |3;mootools.html;1421.8364888037875;1443.667956370035;1462.7952086707862;1492.596998810322;1496.393960446019;17146.91426542867;17757.112144392795;17850.642987140265;17887.195076221567;17892.642147157065;17466.12669366533;17607.559811004732;17617;17659.117044147806;17697.11514424277;2618.528664840328;2659.800514961376;2697.6223328733995;2700.4194098268867;2712.7965402594787;2784.6101545783504;2799.8180118292244;2815.07102656124;2817.9573557783547;2819;2651.893924243028;2902.9419411611757;2920.2553348896004;2925.107842108156;2927.956080658792;2632.736726327371;2654.6681664791804;2670.973290267111;2682.932926676829;2687.9596806047925;2778.9861050694817;2827.9010234641896;2845.046909285392;2868.584055311989;2874.856257187132;16256.349746010146;16417.343306267736;16559.586010349718;16622.25199866009;16654;8498;8711.128887111301;8745.956270218672;8755.036945936006;8759.649614015432;5530.5299049580835;5670.177824215466;5736.282964629421;5753.050746626802;5786.450287222707;2061.072517367191;2071.078370125295;2076.273304343483;2096.528281136732;2115.7038014677955;31028;31261.687383126104;31370.686293137005;31375.215619609466;31436.842815786003;7101.360877521048;7232;7238.167610724729;7339.266073392618;7340.37606803417;19268.903655481634;19393.127309271116;19397.806021939883;19410.2235910562;19438.222471101;8343.582820858932;8511.787205319917;8513.489190648581;8514.14858514156;8519.531425771642;7702.96148519265;7928.246816552533;7955.164707705723;7984.361251099898;7995.320397766139;5334.626576139633;5503.174523821459;5505.807296744675;5537.058700021006;5615.185798059259;1448.3337664674157;1501.3619211834925;1647.62104715916;1648.1100205888924;1656.1470842516114;962.1340793286098;971.2861047130353;978.9021097890296;982;983.6311383231289;9356.204722598519;9568.234541236685;9630.133288003974;9770.804583908424;9813.264005199639;779.4777499075633;781.7459325719165;783.2793829676712;784.2510402565537;861.0012385632762;5543.584231182677;5681.857953551194;5743.1385292206505;5950.107483877367;6015.879682406327;24542;25413.74586254151;25417;25672.48655026889;25717.3570660735;23856.16503422372;25035.374115647253;25113.748862511507;25122.246332609684;25243.747562524506;12308.753824923451;12350.38248087592;12440.19138755978;12579.182353147016;12620.432080556397;9220.538973051454;9301.116393942564;9372.906270937476;9564.521773911138;9614.855777163488;20867.06098225614;21065;21337.89331053335;21540.892295539048;21736.673949890446;21711.565768684854;21762.782372176076;21783.12867485283;21800.236991705213;21911.233106841184;12043.397830108284;12284.570040048555;12306.569270075504;12338.136330456782;12339.75320493603;15396.615084622526;15612.765808513108;15738.370465181264;15740.763888541911;15800.60498487547;12503.312317822243;12589.307588082744;12680.873191267969;13063.412146453242;13164.40760165814;11881.108916831445;11941.582044628396;11982.58060967862;12023.75952480963;12379.195352302071;10558.472076395996;10606.628767993083;10637.9468102659;10768.46157692128;10777.838332425177;7969.681212751425;8083.919160808552;8123.309518690978;8179.32086609251;8294.253517183482;8427.241548260687;8427.662893484192;8472.915270847212;8488.660453582035;8508.787280318042 16:39:56 INFO - PID 3819 | |4;prototype.html;554.8862483190946;558.6899270904648;571.4057380324463;581.874896897167;586.7066466766616;5993.703463095297;6067.362926892673;6197.566170368076;6218.968905155468;6237.5009999200065;6163.322034576193;6178.38216178383;6213.068039794033;6217.253929528451;6241.126242326067;5067.670601410906;5083.415407228161;5084.593232541388;5106.64253502255;5158.484151584849;4836.733979631119;4909.656324057318;4928.926066109011;5050.78781092537;5057.5701065409485;4907.129329342339;4909.263610458424;4927.1377508935975;4934.6299027572895;4956.2565615157655;4895.290182923456;4905;4908.386451693538;4928.383952005999;4929.4824043475455;4468.50846406895;4478.977605111953;4498.8425405110665;4509.661775366828;4512.887177820548;6137.570370074097;6166.814995550096;6214.8135555933395;6220.502359811249;6272.714093610799;5843.357230704619;5847.649141051551;5853.5317174625925;5880.9411905880825;5887.5584331174905;6478.54650174488;6504.674766261715;6552.213734351861;6562.901556476609;6580.967095164541;4940.382452193476;4954.3063971044085;4959.256111583255;4981.178105612569;5009.474005229435;6842;6842.589444633288;6912.723491060352;6915.861682766316;6931.965340173318;5120.564751996122;5131.255373173139;5144.6913185209005;5147.871303217449;5161.561267292247;5189.377274727057;5196;5198.298229738937;5207.29701490294;5219.269302297681;5724.77100915967;5741.913871291934;5774.902768473977;5807.448292412214;5814.738336774855;6252.74989000444;6510.972397835029;6571.441427478718;6587.242467116247;6635.2037755469655;1728.6542691461757;1736.1145815634118;1746.7641868347864;1777.3779177288104;1787.5352408373917;1251.205484517338;1261.0983147049903;1265.171312790124;1291.709365392779;1294.087668193921;5842.591018628656;5887.470127688529;5895.852603684943;5934.881302374015;6012.278526576752;6371.872562548816;6544.345565443513;6572.14562106923;6628.5691430056895;6650.83372915681;6022.427869352405;6033.125196846433;6051.636901785907;6068.998615228438;6126.908096378558;3433.1931995980926;3503.474478828145;3518.859245630197;3553.3959226931483;3558.5907620623443;6893.724251029903;6942.861142777117;6942.93057069433;6974;6983.825404364931;6853.554518956252;6882.518223724392;6883.449324054063;6906;6932.722691092401;6804.863902721819;6956.756513522002;6973.6164510952385;6989.26612705679;6995.685194166274;6605.126769855128;6683.164604424447;6691.59850408977;6705.6647167642395;6721.563098398588;6649.933500664932;6671.6997735103005;6678.23200331968;6703.631300278336;6705.290151011461;6857.314268573302;6945.513814032969;7000.964995174992;7027.15674119109;7040.577565346096;5610.663360198238;5626.690532020778;5670.121131224667;5671;5710.601547350206;6568.244651865097;6682.9331706682315;6697;6717.361850624183;6789.864202716017;6191.752329906753;6286.842828929313;6380.840478988062;6415.615063096229;6437.613743175424;6406.807795766134;6420.459089818503;6447.290798012121;6457.321981192095;6472.514561407819;6217.253929528486;6257.405546473078;6262.405071518198;6307.206523042429;6342.714577843916;6388.712507937061;6430;6472;6484.221893372825;6485.546011779319;6255.499560035095;6294.937050629435;6318.6840657965995;6336.524760643062;6337.524685648503 16:39:56 INFO - PID 3819 | |5;yui.html;970.3062310448031;973.3770386952348;987.0672214757053;991.8214721350154;1004.7136566078667;16995.830041699595;17164.742528862076;17186.398476053324;17202.139893005347;17208.82791172088;16865.325386984536;18340.633187336247;18341.082945852722;18349.54126146847;18366.81633183668;1042.3381152967881;1073.8603981482436;1074.2104553153426;1074.527208028469;1074.7635520185586;1058.481344141369;1066.8826429092794;1068.5565490321508;1068.834330678746;1069.0271852614123;1081.9404932728696;1110.7001109700377;1114.8439218509416;1123.775244951009;1123.966281011571;1110.2838669058492;1110.8056090184225;1115.1747706697067;1116.6650004998469;1116.966491005271;805.0942689474341;808.6159074439653;825.1995564302617;826.3802148388709;826.6569373709904;17500.562485937826;17614.295428182857;17720.91139544294;17742.29030838778;17804.91097544517;20740.792592074038;20891.8955405222;20957.509516149974;21140.471488212763;21322.14711411557;16912;17005.914970425194;17175.141242937927;17282.395116171;17467.213975371138;3877.864274750398;3878.0886491674432;3894.240623078501;3899.454076429302;3903.551091624471;117773;156264.21867890703;157290.21354893266;157583;159281;16040.358385664442;16041.919790400972;16258.105804180883;16478.2584783685;16656.083915384526;33656.66343336536;33758.49362259568;33801.661983379854;33978.49032264518;35167.648323516434;8586.742397728078;8657.39398242117;8683;8684.565771711515;8686.826263474695;4147.52303485103;4160.43834082395;4210.221109094828;4218.472690913636;4228.76741779199;5912.438318359749;6002.189704389852;6051.062085376773;6109.327973922865;6151.9384806151365;1114.3035602748282;1142.149098921309;1161.7095726068483;1163.4299193395345;1165.411467209071;698.9021536984826;723.4104205072954;740.1155619035201;749.9475036747484;750.7822731407831;12953.352332383532;13526.526571569948;13526.864731352758;13595.592132236048;13873;659.5119611487464;678.4945215814151;688.6281408039603;692.1728534401443;697.689528159964;5760.884782304414;5812.564057695605;5858.740370820209;6018.097285407224;6054.061620448838;149856.2507187457;150935;152392;154345;155753;100764.49617751864;121826;127533.36233318775;128283;133130;112817;114035;114119;116034;116164.41917790526;14519.05626134298;14555.199464029156;14695.853041469449;14815.629609259855;15010.624734381729;54415.72792136014;55109;55787;55999.16001259903;56532.434675652716;71685;72713.27286727064;73575.26424735898;73706.26293736995;73746;17562.12189390551;17940.551486212426;18090.18594163292;18263.726044109615;18305.633887322445;22725.772742273028;22839.20062797794;22987.310380688607;23162.652560211274;23233.30300091;20352.796472035683;20803.89598052;20818;21014.68477972801;21155.682664759734;14831.11013339203;14923.776143357642;15033.098014119189;15084.472043478865;15199.240037997835;20595.794042059388;20896.268630597857;20964.266250681154;21035.8948205258;21225.787742123;13876.236806975714;14025.158490490603;14271.357788899732;14278.143311401349;14353.497627582985;14731.926340368229;14861.777073344125;14890.851091488947;14991.325390357242;15091.54725358241 16:39:56 INFO - PID 3819 | __end_tp_report 16:39:56 INFO - PID 3819 | __start_cc_report 16:39:56 INFO - PID 3819 | _x_x_mozilla_cycle_collect,351 16:39:56 INFO - PID 3819 | __end_cc_report 16:39:56 INFO - PID 3819 | __startTimestamp1505432396072__endTimestamp 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | ------- Summary: start ------- 16:39:56 INFO - PID 3819 | Number of tests: 6 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#0] dojo.html Cycles:165 Average:6197.48 Median:6447.23 stddev:858.17 (13.3%) stddev-sans-first:839.86 16:39:56 INFO - PID 3819 | Values: 3795.6 3830.9 3859.2 3864.0 3886.4 6082.1 6225.7 6265.9 6287.1 6304.6 6198.9 6252.5 6272.9 6291.1 6386.3 5527.9 5567.9 5568.5 5626.3 5645.9 665.3 5582.5 5642.4 5701.6 5708.0 5553.2 5596.8 5602.4 5687.0 5688.9 5571.6 5575.5 5641.7 5652.3 5665.3 5569.9 5586.6 5588.9 5650.9 5661.4 6203.6 6258.0 6263.6 6289.6 6291.4 6725.6 6748.9 6813.7 6823.0 6824.1 6660.7 6721.1 6731.5 6743.4 6774.2 6223.3 6246.3 6246.3 6249.3 6251.2 6885.8 6905.8 6914.9 7021.5 7031.8 6707.9 6715.6 6794.9 6804.0 6812.5 6817.3 6819.5 6876.1 6900.9 6908.8 6606.3 6677.4 6696.8 6755.1 6797.6 6741.6 6789.7 6797.7 6821.5 6824.7 4956.9 4960.7 5017.9 5026.3 5034.7 4439.7 4491.7 4500.2 4513.8 4532.8 6128.1 6158.7 6160.4 6160.7 6238.6 6722.1 6796.4 6825.4 6825.7 6844.7 6121.4 6164.0 6178.2 6223.3 6238.8 5417.2 5418.5 5430.5 5469.8 5508.0 7083.8 7134.5 7136.4 7137.3 7139.4 6540.6 6691.9 6710.1 6750.3 6843.3 6942.6 6947.4 7082.5 7120.2 7137.1 6700.5 6703.5 6776.1 6779.3 6791.8 6778.9 6781.4 6839.2 6841.0 6841.3 6498.9 6536.4 6566.3 6571.9 6596.5 6483.4 6492.0 6573.5 6574.8 6579.8 6435.5 6439.1 6442.0 6530.3 6545.2 6447.2 6490.1 6508.5 6555.9 6596.5 6214.9 6267.2 6319.5 6367.9 6368.5 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#1] ext.html Cycles:180 Average:42252.94 Median:37095.72 stddev:61371.05 (165.4%) stddev-sans-first:61464.85 16:39:56 INFO - PID 3819 | Values: 951.2 961.1 985.1 1008.8 1013.0 45327.5 45899.8 45939.0 46172.8 46178.3 45906.0 46271.8 46355.8 46419.8 46444.5 8200.3 8317.2 8334.1 8342.6 8355.2 8137.2 8259.6 8271.7 8314.4 8322.5 8334.2 8363.6 8384.0 8386.2 8397.7 8268.2 8287.5 8307.0 8325.1 8326.3 8107.1 8164.0 8164.4 8178.3 8181.5 42054.6 42372.8 42383.0 42453.8 42461.2 3728.3 3770.0 3771.1 3772.3 3772.8 34118.5 34256.8 34308.8 34420.5 34465.3 5361.6 5424.3 5435.9 5466.9 5522.2 215610.0 216491.0 216749.0 217228.0 218204.0 52197.0 52202.2 52234.0 52341.7 52469.0 54047.5 54308.7 54493.7 54506.7 54641.7 16717.3 16925.9 16926.3 16932.3 16958.3 13731.6 13789.2 13805.6 13806.2 13808.5 13840.7 14129.9 14134.7 14167.4 14303.3 5275.6 5320.0 5350.8 5387.5 5474.1 1074.3 1076.4 1082.2 1086.8 1097.2 25796.7 26057.9 26240.6 26389.9 26539.9 1174.9 1182.6 1193.1 1195.6 1198.5 13810.6 13815.0 13815.3 13951.0 14144.2 257442.0 258231.0 258709.0 285890.0 287987.0 61899.1 62028.0 62082.4 62096.7 62157.4 1482.9 1486.6 1490.8 1507.1 1514.5 30825.4 31000.0 31080.1 31191.4 31320.5 37073.8 41649.0 41809.0 41885.2 42104.6 217665.0 218226.0 218394.0 219197.0 219581.0 36772.4 36797.3 37034.3 37117.6 37184.0 47302.5 47600.8 47887.8 48314.8 48464.0 35590.6 35820.6 35883.8 35940.5 36170.6 35753.9 35935.0 35938.0 35949.6 36166.6 42545.9 42584.6 42784.0 43034.6 43152.4 34335.3 34993.0 35322.5 35479.8 35875.6 25698.4 25960.1 26009.3 26045.5 26459.5 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#2] jquery.html Cycles:180 Average:39038.40 Median:22967.10 stddev:101834.54 (443.4%) stddev-sans-first:102079.29 16:39:56 INFO - PID 3819 | Values: 588.7 596.2 598.1 600.4 625.3 23072.5 23998.4 24094.8 24187.4 24201.8 24037.8 26218.6 26348.7 26385.0 26405.5 6743.3 6800.8 6830.7 6831.7 6848.1 6632.9 6873.7 6874.6 6884.4 6894.2 6820.8 6839.4 6857.3 6862.9 6875.9 6595.5 6817.4 6819.6 6832.3 6847.4 6366.1 6379.4 6386.8 6389.4 6407.6 29129.7 29728.3 29769.6 29791.6 29818.3 2150.4 2160.7 2186.6 2188.4 2191.7 18968.1 20110.4 20180.6 20320.4 20328.0 2545.3 2578.7 2620.3 2637.0 2638.2 136303.3 142675.0 142757.0 144627.3 150624.0 15457.2 15680.8 16166.5 16188.9 16483.5 25113.0 25152.2 25164.0 25222.1 25362.1 10170.2 10328.4 10439.2 10481.2 10510.7 9317.0 9391.1 9429.7 9555.6 9623.5 9560.9 9627.0 9925.2 9972.0 9982.3 2887.6 2944.9 2955.6 2962.8 3000.7 1028.7 1034.7 1047.9 1060.5 1082.4 20693.8 20746.2 20802.0 20906.6 21154.4 1094.3 1106.3 1110.6 1111.3 1124.5 10985.4 11105.7 11169.7 11287.6 11410.5 593592.0 610150.0 617346.0 617747.0 619714.0 118041.0 120602.0 120662.4 121776.0 123300.0 1215.6 1226.2 1262.3 1264.4 1269.0 17862.6 18028.7 18110.5 18410.7 18562.8 60324.4 60765.4 61277.1 61310.7 62158.0 74729.3 75043.2 75168.2 76145.9 76334.0 14759.4 14993.2 15012.6 15032.8 15097.0 22938.4 22995.8 23091.0 23257.5 23325.8 18854.9 19041.2 19155.9 19227.3 19467.3 14603.2 15715.8 16453.2 16577.6 17241.2 19094.6 19378.2 19416.9 19528.2 19966.3 14842.2 14885.5 14906.9 14970.5 15047.7 18675.0 18993.2 19004.2 19178.1 19364.3 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#3] mootools.html Cycles:180 Average:10484.18 Median:2676.95 stddev:7813.91 (291.9%) stddev-sans-first:7806.17 16:39:56 INFO - PID 3819 | Values: 1421.8 1443.7 1462.8 1492.6 1496.4 17146.9 17757.1 17850.6 17887.2 17892.6 17466.1 17607.6 17617.0 17659.1 17697.1 2618.5 2659.8 2697.6 2700.4 2712.8 2784.6 2799.8 2815.1 2818.0 2819.0 2651.9 2902.9 2920.3 2925.1 2928.0 2632.7 2654.7 2671.0 2682.9 2688.0 2779.0 2827.9 2845.0 2868.6 2874.9 16256.3 16417.3 16559.6 16622.3 16654.0 8498.0 8711.1 8746.0 8755.0 8759.6 5530.5 5670.2 5736.3 5753.1 5786.5 2061.1 2071.1 2076.3 2096.5 2115.7 31028.0 31261.7 31370.7 31375.2 31436.8 7101.4 7232.0 7238.2 7339.3 7340.4 19268.9 19393.1 19397.8 19410.2 19438.2 8343.6 8511.8 8513.5 8514.1 8519.5 7703.0 7928.2 7955.2 7984.4 7995.3 5334.6 5503.2 5505.8 5537.1 5615.2 1448.3 1501.4 1647.6 1648.1 1656.1 962.1 971.3 978.9 982.0 983.6 9356.2 9568.2 9630.1 9770.8 9813.3 779.5 781.7 783.3 784.3 861.0 5543.6 5681.9 5743.1 5950.1 6015.9 24542.0 25413.7 25417.0 25672.5 25717.4 23856.2 25035.4 25113.7 25122.2 25243.7 12308.8 12350.4 12440.2 12579.2 12620.4 9220.5 9301.1 9372.9 9564.5 9614.9 20867.1 21065.0 21337.9 21540.9 21736.7 21711.6 21762.8 21783.1 21800.2 21911.2 12043.4 12284.6 12306.6 12338.1 12339.8 15396.6 15612.8 15738.4 15740.8 15800.6 12503.3 12589.3 12680.9 13063.4 13164.4 11881.1 11941.6 11982.6 12023.8 12379.2 10558.5 10606.6 10637.9 10768.5 10777.8 7969.7 8083.9 8123.3 8179.3 8294.3 8427.2 8427.7 8472.9 8488.7 8508.8 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#4] prototype.html Cycles:180 Average:5576.53 Median:6185.07 stddev:1551.50 (25.1%) stddev-sans-first:1509.38 16:39:56 INFO - PID 3819 | Values: 554.9 558.7 571.4 581.9 586.7 5993.7 6067.4 6197.6 6219.0 6237.5 6163.3 6178.4 6213.1 6217.3 6241.1 5067.7 5083.4 5084.6 5106.6 5158.5 4836.7 4909.7 4928.9 5050.8 5057.6 4907.1 4909.3 4927.1 4934.6 4956.3 4895.3 4905.0 4908.4 4928.4 4929.5 4468.5 4479.0 4498.8 4509.7 4512.9 6137.6 6166.8 6214.8 6220.5 6272.7 5843.4 5847.6 5853.5 5880.9 5887.6 6478.5 6504.7 6552.2 6562.9 6581.0 4940.4 4954.3 4959.3 4981.2 5009.5 6842.0 6842.6 6912.7 6915.9 6932.0 5120.6 5131.3 5144.7 5147.9 5161.6 5189.4 5196.0 5198.3 5207.3 5219.3 5724.8 5741.9 5774.9 5807.4 5814.7 6252.7 6511.0 6571.4 6587.2 6635.2 1728.7 1736.1 1746.8 1777.4 1787.5 1251.2 1261.1 1265.2 1291.7 1294.1 5842.6 5887.5 5895.9 5934.9 6012.3 6371.9 6544.3 6572.1 6628.6 6650.8 6022.4 6033.1 6051.6 6069.0 6126.9 3433.2 3503.5 3518.9 3553.4 3558.6 6893.7 6942.9 6942.9 6974.0 6983.8 6853.6 6882.5 6883.4 6906.0 6932.7 6804.9 6956.8 6973.6 6989.3 6995.7 6605.1 6683.2 6691.6 6705.7 6721.6 6649.9 6671.7 6678.2 6703.6 6705.3 6857.3 6945.5 7001.0 7027.2 7040.6 5610.7 5626.7 5670.1 5671.0 5710.6 6568.2 6682.9 6697.0 6717.4 6789.9 6191.8 6286.8 6380.8 6415.6 6437.6 6406.8 6420.5 6447.3 6457.3 6472.5 6217.3 6257.4 6262.4 6307.2 6342.7 6388.7 6430.0 6472.0 6484.2 6485.5 6255.5 6294.9 6318.7 6336.5 6337.5 16:39:56 INFO - PID 3819 | 16:39:56 INFO - PID 3819 | [#5] yui.html Cycles:180 Average:27828.70 Median:17731.60 stddev:41208.67 (232.4%) stddev-sans-first:41274.92 16:39:56 INFO - PID 3819 | Values: 970.3 973.4 987.1 991.8 1004.7 16995.8 17164.7 17186.4 17202.1 17208.8 16865.3 18340.6 18341.1 18349.5 18366.8 1042.3 1073.9 1074.2 1074.5 1074.8 1058.5 1066.9 1068.6 1068.8 1069.0 1081.9 1110.7 1114.8 1123.8 1124.0 1110.3 1110.8 1115.2 1116.7 1117.0 805.1 808.6 825.2 826.4 826.7 17500.6 17614.3 17720.9 17742.3 17804.9 20740.8 20891.9 20957.5 21140.5 21322.1 16912.0 17005.9 17175.1 17282.4 17467.2 3877.9 3878.1 3894.2 3899.5 3903.6 117773.0 156264.2 157290.2 157583.0 159281.0 16040.4 16041.9 16258.1 16478.3 16656.1 33656.7 33758.5 33801.7 33978.5 35167.6 8586.7 8657.4 8683.0 8684.6 8686.8 4147.5 4160.4 4210.2 4218.5 4228.8 5912.4 6002.2 6051.1 6109.3 6151.9 1114.3 1142.1 1161.7 1163.4 1165.4 698.9 723.4 740.1 749.9 750.8 12953.4 13526.5 13526.9 13595.6 13873.0 659.5 678.5 688.6 692.2 697.7 5760.9 5812.6 5858.7 6018.1 6054.1 149856.3 150935.0 152392.0 154345.0 155753.0 100764.5 121826.0 127533.4 128283.0 133130.0 112817.0 114035.0 114119.0 116034.0 116164.4 14519.1 14555.2 14695.9 14815.6 15010.6 54415.7 55109.0 55787.0 55999.2 56532.4 71685.0 72713.3 73575.3 73706.3 73746.0 17562.1 17940.6 18090.2 18263.7 18305.6 22725.8 22839.2 22987.3 23162.7 23233.3 20352.8 20803.9 20818.0 21014.7 21155.7 14831.1 14923.8 15033.1 15084.5 15199.2 20595.8 20896.3 20964.3 21035.9 21225.8 13876.2 14025.2 14271.4 14278.1 14353.5 14731.9 14861.8 14890.9 14991.3 15091.5 16:39:56 INFO - PID 3819 | -------- Summary: end -------- 16:39:56 INFO - PID 3819 | 16:39:56 INFO - TEST-INFO | 3819: exit 0 16:39:56 INFO - TEST-OK | dromaeo_css | took 1109364ms 16:39:56 INFO - TEST-START | kraken 16:39:56 INFO - Initialising browser for kraken test... 16:39:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48978/getInfo.html -profile /tmp/tmp1FkNQy/profile 16:39:56 INFO - TEST-INFO | started process 4184 (/builds/slave/test/build/application/firefox/firefox http://localhost:48978/getInfo.html) 16:40:01 INFO - TEST-INFO | 4184: exit 0 16:40:01 INFO - Browser initialized. 16:40:01 INFO - Running cycle 1/1 for kraken test... 16:40:01 INFO - Using env: {'DISPLAY': ':0', 16:40:01 INFO - 'HOME': '/home/cltbld', 16:40:01 INFO - 'JSGC_DISABLE_POISONING': '1', 16:40:01 INFO - 'LANG': 'en_US.UTF-8', 16:40:01 INFO - 'LANGUAGE': 'en_US:en', 16:40:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:40:01 INFO - 'LOGNAME': 'cltbld', 16:40:01 INFO - 'MAIL': '/var/mail/cltbld', 16:40:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:40:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:40:01 INFO - 'MOZ_CRASHREPORTER': '1', 16:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:40:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:40:01 INFO - 'MOZ_NO_REMOTE': '1', 16:40:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:40:01 INFO - 'NO_EM_RESTART': '1', 16:40:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:40:01 INFO - 'PWD': '/builds/slave/test', 16:40:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:40:01 INFO - 'RUST_BACKTRACE': 'full', 16:40:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:40:01 INFO - 'SHELL': '/bin/bash', 16:40:01 INFO - 'SHLVL': '1', 16:40:01 INFO - 'STYLO_FORCE_DISABLED': '1', 16:40:01 INFO - 'TERM': 'linux', 16:40:01 INFO - 'TMOUT': '86400', 16:40:01 INFO - 'USER': 'cltbld', 16:40:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272', 16:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:40:01 INFO - '_': '/tools/buildbot/bin/python'} 16:40:01 INFO - TEST-INFO | started process 4415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FkNQy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:02 INFO - PID 4415 | 16:40:02 INFO - PID 4415 | (/builds/slave/test/build/application/firefox/firefox:4464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:40:02 INFO - PID 4415 | 16:40:12 INFO - PID 4415 | RSS: Main: 166928384 16:40:12 INFO - PID 4415 | 16:40:15 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:15 INFO - PID 4415 | RSS: Main: 171851776 16:40:15 INFO - PID 4415 | 16:40:18 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-dft) 16:40:19 INFO - PID 4415 | RSS: Main: 172339200 16:40:19 INFO - PID 4415 | 16:40:22 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-fft) 16:40:22 INFO - PID 4415 | RSS: Main: 167936000 16:40:22 INFO - PID 4415 | 16:40:24 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator) 16:40:25 INFO - PID 4415 | RSS: Main: 168755200 16:40:25 INFO - PID 4415 | 16:40:27 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:27 INFO - PID 4415 | RSS: Main: 168783872 16:40:27 INFO - PID 4415 | 16:40:31 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:31 INFO - PID 4415 | RSS: Main: 168644608 16:40:31 INFO - PID 4415 | 16:40:35 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:35 INFO - PID 4415 | RSS: Main: 169459712 16:40:35 INFO - PID 4415 | 16:40:38 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial) 16:40:39 INFO - PID 4415 | RSS: Main: 171241472 16:40:39 INFO - PID 4415 | 16:40:40 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:41 INFO - PID 4415 | RSS: Main: 171036672 16:40:41 INFO - PID 4415 | 16:40:43 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:43 INFO - PID 4415 | RSS: Main: 170835968 16:40:43 INFO - PID 4415 | 16:40:45 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:40:46 INFO - PID 4415 | RSS: Main: 167604224 16:40:46 INFO - PID 4415 | 16:40:49 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:40:50 INFO - PID 4415 | RSS: Main: 168296448 16:40:50 INFO - PID 4415 | 16:40:52 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:40:53 INFO - PID 4415 | RSS: Main: 169279488 16:40:53 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48978/tests/kraken/driver.html?testName=ai-astar) 16:40:55 INFO - PID 4415 | RSS: Main: 170635264 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | __start_tp_report 16:40:55 INFO - PID 4415 | _x_x_mozilla_page_load 16:40:55 INFO - PID 4415 | _x_x_mozilla_page_load_details 16:40:55 INFO - PID 4415 | |i|pagename|runs| 16:40:55 INFO - PID 4415 | |0;ai-astar;105;105;105;106;104;104;108;106;109;107 16:40:55 INFO - PID 4415 | |1;audio-beat-detection;115;124;121;111;111;112;111;110;146;111 16:40:55 INFO - PID 4415 | |2;audio-dft;161;162;161;162;162;162;162;160;165;173 16:40:55 INFO - PID 4415 | |3;audio-fft;73;74;73;73;72;74;72;73;74;79 16:40:55 INFO - PID 4415 | |4;audio-oscillator;79;78;78;79;80;77;78;78;78;77 16:40:55 INFO - PID 4415 | |5;imaging-gaussian-blur;113;113;114;110;113;115;113;114;110;113 16:40:55 INFO - PID 4415 | |6;imaging-darkroom;149;149;158;150;149;152;152;151;149;150 16:40:55 INFO - PID 4415 | |7;imaging-desaturate;95;93;94;94;94;94;94;95;94;93 16:40:55 INFO - PID 4415 | |8;json-parse-financial;44;49;44;49;42;44;44;44;44;47 16:40:55 INFO - PID 4415 | |9;json-stringify-tinderbox;37;37;37;36;38;37;37;37;37;37 16:40:55 INFO - PID 4415 | |10;stanford-crypto-aes;74;77;71;75;71;70;70;71;77;72 16:40:55 INFO - PID 4415 | |11;stanford-crypto-ccm;104;104;111;105;110;110;111;109;102;117 16:40:55 INFO - PID 4415 | |12;stanford-crypto-pbkdf2;156;152;150;167;155;152;158;151;159;157 16:40:55 INFO - PID 4415 | |13;stanford-crypto-sha256-iterative;59;60;65;66;60;59;61;61;63;59 16:40:55 INFO - PID 4415 | __end_tp_report 16:40:55 INFO - PID 4415 | __start_cc_report 16:40:55 INFO - PID 4415 | _x_x_mozilla_cycle_collect,889 16:40:55 INFO - PID 4415 | __end_cc_report 16:40:55 INFO - PID 4415 | __startTimestamp1505432455343__endTimestamp 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | ------- Summary: start ------- 16:40:55 INFO - PID 4415 | Number of tests: 14 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.66 (1.6%) stddev-sans-first:1.73 16:40:55 INFO - PID 4415 | Values: 105.0 105.0 105.0 106.0 104.0 104.0 108.0 106.0 109.0 107.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:113.50 stddev:11.19 (9.9%) stddev-sans-first:11.84 16:40:55 INFO - PID 4415 | Values: 115.0 124.0 121.0 111.0 111.0 112.0 111.0 110.0 146.0 111.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:3.74 (2.3%) stddev-sans-first:3.90 16:40:55 INFO - PID 4415 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 162.0 160.0 165.0 173.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#3] audio-fft Cycles:10 Average:73.70 Median:73.50 stddev:2.00 (2.7%) stddev-sans-first:2.11 16:40:55 INFO - PID 4415 | Values: 73.0 74.0 73.0 73.0 72.0 74.0 72.0 73.0 74.0 79.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 16:40:55 INFO - PID 4415 | Values: 79.0 78.0 78.0 79.0 80.0 77.0 78.0 78.0 78.0 77.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:1.62 (1.4%) stddev-sans-first:1.72 16:40:55 INFO - PID 4415 | Values: 113.0 113.0 114.0 110.0 113.0 115.0 113.0 114.0 110.0 113.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:2.77 (1.8%) stddev-sans-first:2.85 16:40:55 INFO - PID 4415 | Values: 149.0 149.0 158.0 150.0 149.0 152.0 152.0 151.0 149.0 150.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 16:40:55 INFO - PID 4415 | Values: 95.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:44.00 stddev:2.38 (5.4%) stddev-sans-first:2.49 16:40:55 INFO - PID 4415 | Values: 44.0 49.0 44.0 49.0 42.0 44.0 44.0 44.0 44.0 47.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.47 (1.3%) stddev-sans-first:0.50 16:40:55 INFO - PID 4415 | Values: 37.0 37.0 37.0 36.0 38.0 37.0 37.0 37.0 37.0 37.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.00 stddev:2.74 (3.8%) stddev-sans-first:2.87 16:40:55 INFO - PID 4415 | Values: 74.0 77.0 71.0 75.0 71.0 70.0 70.0 71.0 77.0 72.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#11] stanford-crypto-ccm Cycles:10 Average:108.30 Median:110.00 stddev:4.52 (4.1%) stddev-sans-first:4.52 16:40:55 INFO - PID 4415 | Values: 104.0 104.0 111.0 105.0 110.0 110.0 111.0 109.0 102.0 117.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.50 stddev:5.03 (3.2%) stddev-sans-first:5.34 16:40:55 INFO - PID 4415 | Values: 156.0 152.0 150.0 167.0 155.0 152.0 158.0 151.0 159.0 157.0 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:2.54 (4.2%) stddev-sans-first:2.55 16:40:55 INFO - PID 4415 | Values: 59.0 60.0 65.0 66.0 60.0 59.0 61.0 61.0 63.0 59.0 16:40:55 INFO - PID 4415 | -------- Summary: end -------- 16:40:55 INFO - PID 4415 | 16:40:55 INFO - PID 4415 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:40:55 INFO - TEST-INFO | 4415: exit 0 16:40:56 INFO - TEST-OK | kraken | took 59264ms 16:40:56 INFO - SUITE-END | took 1168s 16:40:56 INFO - Completed test suite (00:19:29) 16:40:56 INFO - javascript benchmark 16:40:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9002.396163204397, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3795.5824859265476, 3830.8850734477974, 3859.2474467478837, 3864.0339915021245, 3886.378179491282, 6082.118092876531, 6225.657588832612, 6265.874682506347, 6287.1198032275515, 6304.59020163689, 6198.938010619892, 6252.499800015999, 6272.9372706272925, 6291.0563415487695, 6386.2975072741965, 5527.861803454925, 5567.916481252784, 5568.470995255444, 5626.324841019084, 5645.943540564583, 665.2652405094593, 5582.525485333752, 5642.407547207546, 5701.600887937846, 5708.0, 5553.222548843165, 5596.776128954837, 5602.355729091166, 5687.033204355249, 5688.857778555528, 5571.609987300891, 5575.470330318613, 5641.746121424505, 5652.349979752299, 5665.291838520185, 5569.860753481195, 5586.636868603528, 5588.888222235532, 5650.886982260373, 5661.433856614347, 6203.596766210227, 6257.968710156466, 6263.561550691454, 6289.591176573508, 6291.43377096059, 6725.630090345029, 6748.898766518457, 6813.6593170341785, 6823.0, 6824.112865327475, 6660.733570657168, 6721.126253587051, 6731.461483081342, 6743.393094621508, 6774.153230846145, 6223.253209614875, 6246.25044994599, 6246.312905580383, 6249.343818898996, 6251.156093927352, 6885.758998435031, 6905.827354316082, 6914.861702765917, 7021.543599666005, 7031.753888613874, 6707.899381509281, 6715.56348837324, 6794.932050679528, 6804.047433359334, 6812.48906332027, 6817.284185160586, 6819.522633415613, 6876.071730316443, 6900.930990690129, 6908.827279317957, 6606.306337834554, 6677.399034086956, 6696.799096027127, 6755.088063111515, 6797.592144471348, 6741.561798483083, 6789.694463749143, 6797.694103765342, 6821.4542836572955, 6824.6928888200155, 4956.925646115311, 4960.652754307236, 5017.9247311290355, 5026.271190677331, 5034.697918124924, 4439.689221754511, 4491.708038977521, 4500.167469018242, 4513.751743654065, 4532.818687252539, 6128.1114238435175, 6158.7228574714245, 6160.353162917919, 6160.722767475474, 6238.625682459067, 6722.058911752359, 6796.388325050769, 6825.385715285549, 6825.69284382204, 6844.657767111724, 6121.357257487989, 6163.96918015407, 6178.165947597017, 6223.284322302993, 6238.75044998195, 5417.18742188667, 5418.539424148991, 5430.5384042356845, 5469.753861076261, 5508.008558459515, 7083.787486375417, 7134.500584959107, 7136.357727804522, 7137.286271372821, 7139.428845692332, 6540.607563546202, 6691.933080669131, 6710.127683401127, 6750.257471678112, 6843.349881761224, 6942.618156001468, 6947.409470194888, 7082.4688148390105, 7120.181179164462, 7137.072180616487, 6700.497462690415, 6703.530752847254, 6776.085228494288, 6779.288174741779, 6791.796246112624, 6778.8983165251575, 6781.38967492928, 6839.247682754993, 6841.042254084333, 6841.315868413119, 6498.902516462352, 6536.444402225864, 6566.277709452052, 6571.934280657132, 6596.538242322991, 6483.351664833667, 6492.0, 6573.506986976092, 6574.8356291093105, 6579.80260592183, 6435.51733619971, 6439.098526206429, 6441.967790161019, 6530.346965303432, 6545.247296560957, 6447.2263328400895, 6490.123833282447, 6508.511861610304, 6555.934440655723, 6596.472282217315, 6214.9067763982675, 6267.185265915402, 6319.46284565817, 6367.9044814328745, 6368.458681011981], "value": 6141.066796826712, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [951.2485136741974, 961.1301771896436, 985.0592683986794, 1008.838585826268, 1012.9544170512327, 45327.546724532745, 45899.770501147446, 45939.0, 46172.769136154275, 46178.3073253901, 45906.0, 46271.76864115683, 46355.768221158934, 46419.76790116045, 46444.53555464453, 8200.30297424718, 8317.168283171664, 8334.083250842403, 8342.582870856464, 8355.206255405727, 8137.186281371874, 8259.587020648974, 8271.710490132846, 8314.376421768362, 8322.500649960992, 8334.166583341648, 8363.581820908961, 8384.0, 8386.245237928586, 8397.748067557952, 8268.214519620626, 8287.461315014534, 8307.044689860622, 8325.125861784516, 8326.292265157468, 8107.108218096005, 8163.959180204061, 8164.428490005702, 8178.345732341458, 8181.509109453393, 42054.579454205676, 42372.78813605912, 42383.0, 42453.78773106146, 42461.1507769846, 3728.3102626014274, 3770.0386401467727, 3771.1326394929047, 3772.264408440355, 3772.773633581994, 34118.48822267668, 34256.82871585651, 34308.82845585781, 34420.48369274463, 34465.310693785985, 5361.571074314045, 5424.321959755031, 5435.918461223085, 5466.863328416782, 5522.22688823565, 215610.0, 216490.99999999843, 216749.0, 217228.0, 218204.0, 52197.0, 52202.21696674477, 52234.0, 52341.7382913083, 52469.0, 54047.45952540503, 54308.728456357465, 54493.72753136209, 54506.727466363205, 54641.726791366586, 16717.331306747838, 16925.91537042307, 16926.322947082226, 16932.32270709158, 16958.321667133176, 13731.588052358446, 13789.241591712553, 13805.585832425044, 13806.17162970225, 13808.516701915585, 13840.723185536233, 14129.940254480955, 14134.717305653829, 14167.362468688934, 14303.284835758379, 5275.57795376369, 5319.973400132974, 5350.839474815684, 5387.542058924957, 5474.069408200616, 1074.258761454594, 1076.39721755817, 1082.1937656445998, 1086.7554800169898, 1097.2045267181388, 25796.74203257981, 26057.869710651325, 26240.60639090415, 26389.868050659625, 26539.867300663373, 1174.8942595166477, 1182.645206438065, 1193.0574845871838, 1195.5636192789568, 1198.5205917632843, 13810.585682429542, 13814.993651840854, 13815.309234538232, 13951.0, 14144.222067786164, 257442.0, 258231.0, 258709.0, 285890.0, 287987.0, 61899.07151392733, 62028.0, 62082.37917620856, 62096.68951655303, 62157.37842621606, 1482.9110253384831, 1486.620911667518, 1490.7838363437459, 1507.1108046252543, 1514.4547962733627, 30825.38349232958, 31000.0, 31080.110166447277, 31191.376172476877, 31320.53019204668, 37073.814630926674, 41649.0, 41809.0, 41885.162296754504, 42104.57895421007, 217665.0, 218226.0, 218394.0, 219197.0, 219581.0, 36772.44841327329, 36797.26405471929, 37034.25931481301, 37117.62882371142, 37184.0, 47302.52697473119, 47600.761996189794, 47887.76056119697, 48314.75842620764, 48464.0, 35590.64409355873, 35820.64179358173, 35883.82058089693, 35940.46089308715, 36170.63829361673, 35753.927382178575, 35935.0, 35938.0, 35949.64050359568, 36166.63833361738, 42545.93635159146, 42584.5741542593, 42784.0, 43034.56965430306, 43152.35271470993, 34335.313293734485, 34993.0, 35322.47016294809, 35479.82260088683, 35875.64124358723, 25698.35754106162, 25960.091396801778, 26009.349766255236, 26045.470667871774, 26459.470810583294], "value": 18823.08940378071, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.7497813429294, 596.2487266044785, 598.1386803003671, 600.3576173494362, 625.2684359299618, 23072.538549229026, 23998.400039999007, 24094.75905240947, 24187.395315117108, 24201.75798242017, 24037.75962240377, 26218.606720899203, 26348.736512634867, 26385.0, 26405.471890562178, 6743.258241593433, 6800.761973330935, 6830.692618832164, 6831.658417079151, 6848.075509806162, 6632.900506492407, 6873.656317184146, 6874.587524748506, 6884.449244060464, 6894.172699276094, 6820.829479263009, 6839.384455399013, 6857.27998560149, 6862.862742745167, 6875.862482750342, 6595.53831231814, 6817.386435220805, 6819.5908245505425, 6832.316768323153, 6847.383735463832, 6366.108744775735, 6379.425851673325, 6386.776462823779, 6389.361063893573, 6407.615543067384, 29129.70870291291, 29728.256793580116, 29769.553456698166, 29791.55312670312, 29818.254543636365, 2150.440885369815, 2160.7407111146763, 2186.584548935697, 2188.365374041526, 2191.6712493126, 18968.14643341053, 20110.39668809938, 20180.596388072303, 20320.390388288375, 20328.0, 2545.338212064858, 2578.742125787425, 2620.331815387064, 2636.9604455933177, 2638.2085374387607, 136303.31848340793, 142675.0, 142757.0, 144627.276863615, 150624.0, 15457.227138643248, 15680.76478852818, 16166.515004549883, 16188.919055404647, 16483.527470879464, 25113.0, 25152.24543263705, 25164.0, 25222.117225897007, 25362.11232606887, 10170.186385089175, 10328.431936243429, 10439.217058720626, 10481.239600457662, 10510.737231569272, 9316.975132735393, 9391.107844754737, 9429.717108486619, 9555.569999350046, 9623.518824058769, 9560.90439095614, 9626.95186524063, 9925.2059835213, 9971.950140249397, 9982.303008488574, 2887.6246088008425, 2944.8527573621664, 2955.6453225613063, 2962.792604517663, 3000.729934305923, 1028.665683652816, 1034.6844212515105, 1047.9318844275251, 1060.5320601632773, 1082.43172334525, 20693.793062069188, 20746.170153194005, 20802.0, 20906.581868362853, 21154.365369038955, 1094.3433939636154, 1106.2975010868156, 1110.5724296146043, 1111.2776695148057, 1124.5389390349917, 10985.39580323074, 11105.722356941142, 11169.664910052712, 11287.604933827277, 11410.543578256777, 593592.0, 610150.0, 617346.0, 617747.0, 619714.0, 118041.0, 120602.0, 120662.396688016, 121776.0, 123300.0, 1215.5745489078752, 1226.2336039975016, 1262.2931158551241, 1264.4310060472824, 1269.0, 17862.642747145244, 18028.729569056213, 18110.54723631867, 18410.72383914269, 18562.81437185665, 60324.39675603188, 60765.392346075976, 61277.08084378827, 61310.693446534264, 62158.0, 74729.2527074744, 75043.24956750362, 75168.24831751832, 76145.85781213397, 76334.0, 14759.409623615365, 14993.17537535446, 15012.624684382978, 15032.774508382601, 15097.0, 22938.42653933665, 22995.770042299362, 23091.0, 23257.53484930258, 23325.76674233236, 18854.905725471286, 19041.238350465825, 19155.90422047881, 19227.327043553407, 19467.318643847397, 14603.196824174773, 15715.842841571895, 16453.177341132658, 16577.585560360603, 17241.22414491376, 19094.61810763805, 19378.224871005565, 19416.90291548533, 19528.21887124556, 19966.30117945865, 14842.18367989771, 14885.479008234659, 14906.925465372604, 14970.47603333878, 15047.699046019237, 18675.0, 18993.240270389582, 19004.23983040663, 19178.13698383604, 19364.322248721226], "value": 12550.240868312783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.8364888037875, 1443.667956370035, 1462.7952086707862, 1492.596998810322, 1496.393960446019, 17146.91426542867, 17757.112144392795, 17850.642987140265, 17887.195076221567, 17892.642147157065, 17466.12669366533, 17607.559811004732, 17617.0, 17659.117044147806, 17697.11514424277, 2618.528664840328, 2659.800514961376, 2697.6223328733995, 2700.4194098268867, 2712.7965402594787, 2784.6101545783504, 2799.8180118292244, 2815.07102656124, 2817.9573557783547, 2819.0, 2651.893924243028, 2902.9419411611757, 2920.2553348896004, 2925.107842108156, 2927.956080658792, 2632.736726327371, 2654.6681664791804, 2670.973290267111, 2682.932926676829, 2687.9596806047925, 2778.9861050694817, 2827.9010234641896, 2845.046909285392, 2868.584055311989, 2874.856257187132, 16256.349746010146, 16417.343306267736, 16559.586010349718, 16622.25199866009, 16654.0, 8498.0, 8711.128887111301, 8745.956270218672, 8755.036945936006, 8759.649614015432, 5530.5299049580835, 5670.177824215466, 5736.282964629421, 5753.050746626802, 5786.450287222707, 2061.072517367191, 2071.078370125295, 2076.273304343483, 2096.528281136732, 2115.7038014677955, 31028.0, 31261.687383126104, 31370.686293137005, 31375.215619609466, 31436.842815786003, 7101.360877521048, 7232.0, 7238.167610724729, 7339.266073392618, 7340.37606803417, 19268.903655481634, 19393.127309271116, 19397.806021939883, 19410.2235910562, 19438.222471101, 8343.582820858932, 8511.787205319917, 8513.489190648581, 8514.14858514156, 8519.531425771642, 7702.96148519265, 7928.246816552533, 7955.164707705723, 7984.361251099898, 7995.320397766139, 5334.626576139633, 5503.174523821459, 5505.807296744675, 5537.058700021006, 5615.185798059259, 1448.3337664674157, 1501.3619211834925, 1647.62104715916, 1648.1100205888924, 1656.1470842516114, 962.1340793286098, 971.2861047130353, 978.9021097890296, 982.0, 983.6311383231289, 9356.204722598519, 9568.234541236685, 9630.133288003974, 9770.804583908424, 9813.264005199639, 779.4777499075633, 781.7459325719165, 783.2793829676712, 784.2510402565537, 861.0012385632762, 5543.584231182677, 5681.857953551194, 5743.1385292206505, 5950.107483877367, 6015.879682406327, 24542.0, 25413.74586254151, 25417.0, 25672.48655026889, 25717.3570660735, 23856.16503422372, 25035.374115647253, 25113.748862511507, 25122.246332609684, 25243.747562524506, 12308.753824923451, 12350.38248087592, 12440.19138755978, 12579.182353147016, 12620.432080556397, 9220.538973051454, 9301.116393942564, 9372.906270937476, 9564.521773911138, 9614.855777163488, 20867.06098225614, 21065.0, 21337.89331053335, 21540.892295539048, 21736.673949890446, 21711.565768684854, 21762.782372176076, 21783.12867485283, 21800.236991705213, 21911.233106841184, 12043.397830108284, 12284.570040048555, 12306.569270075504, 12338.136330456782, 12339.75320493603, 15396.615084622526, 15612.765808513108, 15738.370465181264, 15740.763888541911, 15800.60498487547, 12503.312317822243, 12589.307588082744, 12680.873191267969, 13063.412146453242, 13164.40760165814, 11881.108916831445, 11941.582044628396, 11982.58060967862, 12023.75952480963, 12379.195352302071, 10558.472076395996, 10606.628767993083, 10637.9468102659, 10768.46157692128, 10777.838332425177, 7969.681212751425, 8083.919160808552, 8123.309518690978, 8179.32086609251, 8294.253517183482, 8427.241548260687, 8427.662893484192, 8472.915270847212, 8488.660453582035, 8508.787280318042], "value": 7273.862954194997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8862483190946, 558.6899270904648, 571.4057380324463, 581.874896897167, 586.7066466766616, 5993.703463095297, 6067.362926892673, 6197.566170368076, 6218.968905155468, 6237.5009999200065, 6163.322034576193, 6178.38216178383, 6213.068039794033, 6217.253929528451, 6241.126242326067, 5067.670601410906, 5083.415407228161, 5084.593232541388, 5106.64253502255, 5158.484151584849, 4836.733979631119, 4909.656324057318, 4928.926066109011, 5050.78781092537, 5057.5701065409485, 4907.129329342339, 4909.263610458424, 4927.1377508935975, 4934.6299027572895, 4956.2565615157655, 4895.290182923456, 4905.0, 4908.386451693538, 4928.383952005999, 4929.4824043475455, 4468.50846406895, 4478.977605111953, 4498.8425405110665, 4509.661775366828, 4512.887177820548, 6137.570370074097, 6166.814995550096, 6214.8135555933395, 6220.502359811249, 6272.714093610799, 5843.357230704619, 5847.649141051551, 5853.5317174625925, 5880.9411905880825, 5887.5584331174905, 6478.54650174488, 6504.674766261715, 6552.213734351861, 6562.901556476609, 6580.967095164541, 4940.382452193476, 4954.3063971044085, 4959.256111583255, 4981.178105612569, 5009.474005229435, 6842.0, 6842.589444633288, 6912.723491060352, 6915.861682766316, 6931.965340173318, 5120.564751996122, 5131.255373173139, 5144.6913185209005, 5147.871303217449, 5161.561267292247, 5189.377274727057, 5196.0, 5198.298229738937, 5207.29701490294, 5219.269302297681, 5724.77100915967, 5741.913871291934, 5774.902768473977, 5807.448292412214, 5814.738336774855, 6252.74989000444, 6510.972397835029, 6571.441427478718, 6587.242467116247, 6635.2037755469655, 1728.6542691461757, 1736.1145815634118, 1746.7641868347864, 1777.3779177288104, 1787.5352408373917, 1251.205484517338, 1261.0983147049903, 1265.171312790124, 1291.709365392779, 1294.087668193921, 5842.591018628656, 5887.470127688529, 5895.852603684943, 5934.881302374015, 6012.278526576752, 6371.872562548816, 6544.345565443513, 6572.14562106923, 6628.5691430056895, 6650.83372915681, 6022.427869352405, 6033.125196846433, 6051.636901785907, 6068.998615228438, 6126.908096378558, 3433.1931995980926, 3503.474478828145, 3518.859245630197, 3553.3959226931483, 3558.5907620623443, 6893.724251029903, 6942.861142777117, 6942.93057069433, 6974.0, 6983.825404364931, 6853.554518956252, 6882.518223724392, 6883.449324054063, 6906.0, 6932.722691092401, 6804.863902721819, 6956.756513522002, 6973.6164510952385, 6989.26612705679, 6995.685194166274, 6605.126769855128, 6683.164604424447, 6691.59850408977, 6705.6647167642395, 6721.563098398588, 6649.933500664932, 6671.6997735103005, 6678.23200331968, 6703.631300278336, 6705.290151011461, 6857.314268573302, 6945.513814032969, 7000.964995174992, 7027.15674119109, 7040.577565346096, 5610.663360198238, 5626.690532020778, 5670.121131224667, 5671.0, 5710.601547350206, 6568.244651865097, 6682.9331706682315, 6697.0, 6717.361850624183, 6789.864202716017, 6191.752329906753, 6286.842828929313, 6380.840478988062, 6415.615063096229, 6437.613743175424, 6406.807795766134, 6420.459089818503, 6447.290798012121, 6457.321981192095, 6472.514561407819, 6217.253929528486, 6257.405546473078, 6262.405071518198, 6307.206523042429, 6342.714577843916, 6388.712507937061, 6430.0, 6472.0, 6484.221893372825, 6485.546011779319, 6255.499560035095, 6294.937050629435, 6318.6840657965995, 6336.524760643062, 6337.524685648503], "value": 5131.1284270373535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.3062310448031, 973.3770386952348, 987.0672214757053, 991.8214721350154, 1004.7136566078667, 16995.830041699595, 17164.742528862076, 17186.398476053324, 17202.139893005347, 17208.82791172088, 16865.325386984536, 18340.633187336247, 18341.082945852722, 18349.54126146847, 18366.81633183668, 1042.3381152967881, 1073.8603981482436, 1074.2104553153426, 1074.527208028469, 1074.7635520185586, 1058.481344141369, 1066.8826429092794, 1068.5565490321508, 1068.834330678746, 1069.0271852614123, 1081.9404932728696, 1110.7001109700377, 1114.8439218509416, 1123.775244951009, 1123.966281011571, 1110.2838669058492, 1110.8056090184225, 1115.1747706697067, 1116.6650004998469, 1116.966491005271, 805.0942689474341, 808.6159074439653, 825.1995564302617, 826.3802148388709, 826.6569373709904, 17500.562485937826, 17614.295428182857, 17720.91139544294, 17742.29030838778, 17804.91097544517, 20740.792592074038, 20891.8955405222, 20957.509516149974, 21140.471488212763, 21322.14711411557, 16912.0, 17005.914970425194, 17175.141242937927, 17282.395116171, 17467.213975371138, 3877.864274750398, 3878.0886491674432, 3894.240623078501, 3899.454076429302, 3903.551091624471, 117773.0, 156264.21867890703, 157290.21354893266, 157583.0, 159281.0, 16040.358385664442, 16041.919790400972, 16258.105804180883, 16478.2584783685, 16656.083915384526, 33656.66343336536, 33758.49362259568, 33801.661983379854, 33978.49032264518, 35167.648323516434, 8586.742397728078, 8657.39398242117, 8683.0, 8684.565771711515, 8686.826263474695, 4147.52303485103, 4160.43834082395, 4210.221109094828, 4218.472690913636, 4228.76741779199, 5912.438318359749, 6002.189704389852, 6051.062085376773, 6109.327973922865, 6151.9384806151365, 1114.3035602748282, 1142.149098921309, 1161.7095726068483, 1163.4299193395345, 1165.411467209071, 698.9021536984826, 723.4104205072954, 740.1155619035201, 749.9475036747484, 750.7822731407831, 12953.352332383532, 13526.526571569948, 13526.864731352758, 13595.592132236048, 13873.0, 659.5119611487464, 678.4945215814151, 688.6281408039603, 692.1728534401443, 697.689528159964, 5760.884782304414, 5812.564057695605, 5858.740370820209, 6018.097285407224, 6054.061620448838, 149856.2507187457, 150935.0, 152392.0, 154345.0, 155753.0, 100764.49617751864, 121826.0, 127533.36233318775, 128283.0, 133130.0, 112817.0, 114035.0, 114119.0, 116034.0, 116164.41917790526, 14519.05626134298, 14555.199464029156, 14695.853041469449, 14815.629609259855, 15010.624734381729, 54415.72792136014, 55109.0, 55787.0, 55999.16001259903, 56532.434675652716, 71685.0, 72713.27286727064, 73575.26424735898, 73706.26293736995, 73746.0, 17562.12189390551, 17940.551486212426, 18090.18594163292, 18263.726044109615, 18305.633887322445, 22725.772742273028, 22839.20062797794, 22987.310380688607, 23162.652560211274, 23233.30300091, 20352.796472035683, 20803.89598052, 20818.0, 21014.68477972801, 21155.682664759734, 14831.11013339203, 14923.776143357642, 15033.098014119189, 15084.472043478865, 15199.240037997835, 20595.794042059388, 20896.268630597857, 20964.266250681154, 21035.8948205258, 21225.787742123, 13876.236806975714, 14025.158490490603, 14271.357788899732, 14278.143311401349, 14353.497627582985, 14731.926340368229, 14861.777073344125, 14890.851091488947, 14991.325390357242, 15091.54725358241], "value": 9830.06693251054, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 106.0, 104.0, 104.0, 108.0, 106.0, 109.0, 107.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 121.0, 111.0, 111.0, 112.0, 111.0, 110.0, 146.0, 111.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 160.0, 165.0, 173.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 73.0, 72.0, 74.0, 72.0, 73.0, 74.0, 79.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 80.0, 77.0, 78.0, 78.0, 78.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 110.0, 113.0, 115.0, 113.0, 114.0, 110.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 158.0, 150.0, 149.0, 152.0, 152.0, 151.0, 149.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 49.0, 44.0, 49.0, 42.0, 44.0, 44.0, 44.0, 44.0, 47.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 36.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 71.0, 75.0, 71.0, 70.0, 70.0, 71.0, 77.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 111.0, 105.0, 110.0, 110.0, 111.0, 109.0, 102.0, 117.0], "value": 108.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 150.0, 167.0, 155.0, 152.0, 158.0, 151.0, 159.0, 157.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 65.0, 66.0, 60.0, 59.0, 61.0, 61.0, 63.0, 59.0], "value": 61.3, "unit": "score"}]}]} 16:40:56 INFO - Return code: 0 16:40:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:56 INFO - # TBPL SUCCESS # 16:40:56 INFO - Running post-action listener: _package_coverage_data 16:40:56 INFO - Running post-action listener: _resource_record_post_action 16:40:56 INFO - [mozharness: 2017-09-14 23:40:56.627475Z] Finished run-tests step (success) 16:40:56 INFO - Running post-run listener: _resource_record_post_run 16:40:56 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 11661312; Write bytes: 516505600; Read time: 3236; Write time: 354056 16:40:56 INFO - TinderboxPrint: CPU usage
13.1% 16:40:56 INFO - TinderboxPrint: I/O read bytes / time
11,661,312 / 3,236 16:40:56 INFO - TinderboxPrint: I/O write bytes / time
516,505,600 / 354,056 16:40:56 INFO - TinderboxPrint: CPU idle
8,225.7 (86.9%) 16:40:56 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 16:40:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74735616; Read time: 0; Write time: 30972 16:40:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:40:56 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 11661312; Write bytes: 441769984; Read time: 3236; Write time: 323084 16:40:57 INFO - Running post-run listener: _upload_blobber_files 16:40:57 INFO - Blob upload gear active. 16:40:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:40:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:58 INFO - (blobuploader) - INFO - Done attempting. 16:40:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:40:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:40:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:59 INFO - (blobuploader) - INFO - Done attempting. 16:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:07 INFO - (blobuploader) - INFO - Done attempting. 16:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:08 INFO - (blobuploader) - INFO - Done attempting. 16:41:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:41:08 INFO - Return code: 0 16:41:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:41:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:41:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edd88cb7aba0b70d0076f7dbb186b1765680676b3f318c1eead4362feaf84c7d62758bc92db635b0960c778761ebec48b9d3bd78ed1efb14b9ff035d3f26e8b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80ec2875fdd979ed9531e6a50fd92ecfa0417b2beab8f30430c5804e5d4adc0fc2e0952243f5aa7cb98c178aada2e520cbc564a3951a10a6af29b708fae772bb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d556a18275045a2e7febf85b14bd131cfd76f1837039669015ed15328bbd4b17e058b489f24c846df758ee7748d6a8df2e73daa8cc6302e706a21a0dd2f60f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0967dc43eeefff062ab395b12253b6e4881e7feffcce9375dbe997fec272e9dec54fc9fa348972accf99f6a5cc3e6e758b15936e8aae8253729759b681497dc0"} 16:41:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:41:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:41:08 INFO - Contents: 16:41:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edd88cb7aba0b70d0076f7dbb186b1765680676b3f318c1eead4362feaf84c7d62758bc92db635b0960c778761ebec48b9d3bd78ed1efb14b9ff035d3f26e8b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80ec2875fdd979ed9531e6a50fd92ecfa0417b2beab8f30430c5804e5d4adc0fc2e0952243f5aa7cb98c178aada2e520cbc564a3951a10a6af29b708fae772bb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d556a18275045a2e7febf85b14bd131cfd76f1837039669015ed15328bbd4b17e058b489f24c846df758ee7748d6a8df2e73daa8cc6302e706a21a0dd2f60f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0967dc43eeefff062ab395b12253b6e4881e7feffcce9375dbe997fec272e9dec54fc9fa348972accf99f6a5cc3e6e758b15936e8aae8253729759b681497dc0"} 16:41:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:41:08 INFO - Copying logs to upload dir... 16:41:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:41:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.626996 ========= master_lag: 0.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-14 16:41:08.343883) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:41:08.348235) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edd88cb7aba0b70d0076f7dbb186b1765680676b3f318c1eead4362feaf84c7d62758bc92db635b0960c778761ebec48b9d3bd78ed1efb14b9ff035d3f26e8b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80ec2875fdd979ed9531e6a50fd92ecfa0417b2beab8f30430c5804e5d4adc0fc2e0952243f5aa7cb98c178aada2e520cbc564a3951a10a6af29b708fae772bb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d556a18275045a2e7febf85b14bd131cfd76f1837039669015ed15328bbd4b17e058b489f24c846df758ee7748d6a8df2e73daa8cc6302e706a21a0dd2f60f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0967dc43eeefff062ab395b12253b6e4881e7feffcce9375dbe997fec272e9dec54fc9fa348972accf99f6a5cc3e6e758b15936e8aae8253729759b681497dc0"} build_url:https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/fuFTFkSSSyONOOWatZLNWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edd88cb7aba0b70d0076f7dbb186b1765680676b3f318c1eead4362feaf84c7d62758bc92db635b0960c778761ebec48b9d3bd78ed1efb14b9ff035d3f26e8b9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80ec2875fdd979ed9531e6a50fd92ecfa0417b2beab8f30430c5804e5d4adc0fc2e0952243f5aa7cb98c178aada2e520cbc564a3951a10a6af29b708fae772bb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1d556a18275045a2e7febf85b14bd131cfd76f1837039669015ed15328bbd4b17e058b489f24c846df758ee7748d6a8df2e73daa8cc6302e706a21a0dd2f60f", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0967dc43eeefff062ab395b12253b6e4881e7feffcce9375dbe997fec272e9dec54fc9fa348972accf99f6a5cc3e6e758b15936e8aae8253729759b681497dc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:41:08.376148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:41:08.376472) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505429696.556619-2094379272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:41:08.459625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:41:08.459944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:41:08.460262) ========= ========= Total master_lag: 0.66 =========