builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1504907805.14 results: success (0) revision: ea7b55d65d76214f97aaae502d65cb26fc6f5659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.140370) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.140837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.141131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.197971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.198405) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 14:56:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2017-09-08 14:56:45 (39.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.484632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.484952) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018190 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.535232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:45.535592) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea7b55d65d76214f97aaae502d65cb26fc6f5659 --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 ea7b55d65d76214f97aaae502d65cb26fc6f5659 --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=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 14:56:45,584 truncating revision to first 12 chars 2017-09-08 14:56:45,584 Setting DEBUG logging. 2017-09-08 14:56:45,584 attempt 1/10 2017-09-08 14:56:45,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea7b55d65d76?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 14:56:45,999 unpacking tar archive at: mozilla-central-ea7b55d65d76/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:46.291752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:46.292090) ========= script_repo_revision: ea7b55d65d76214f97aaae502d65cb26fc6f5659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:46.292511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:46.292831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 14:56:46.306544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 14:56:46.306957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:56:46 INFO - MultiFileLogger online at 20170908 14:56:46 in /builds/slave/test 14:56:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:56:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:56:46 INFO - {'append_to_log': False, 14:56:46 INFO - 'base_work_dir': '/builds/slave/test', 14:56:46 INFO - 'blob_upload_branch': 'Firefox', 14:56:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:56:46 INFO - 'branch': 'Firefox', 14:56:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:56:46 INFO - 'code_coverage': False, 14:56:46 INFO - 'config_files': ('talos/linux_config.py',), 14:56:46 INFO - 'default_actions': ('clobber', 14:56:46 INFO - 'read-buildbot-config', 14:56:46 INFO - 'download-and-extract', 14:56:46 INFO - 'populate-webroot', 14:56:46 INFO - 'create-virtualenv', 14:56:46 INFO - 'install', 14:56:46 INFO - 'setup-mitmproxy', 14:56:46 INFO - 'run-tests'), 14:56:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:56:46 INFO - 'disable_ccov_upload': False, 14:56:46 INFO - 'disable_stylo': False, 14:56:46 INFO - 'download_minidump_stackwalk': True, 14:56:46 INFO - 'download_symbols': 'ondemand', 14:56:46 INFO - 'enable_stylo': False, 14:56:46 INFO - 'enable_webrender': False, 14:56:46 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 14:56:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:56:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:56:46 INFO - 'gecko_profile': False, 14:56:46 INFO - 'gecko_profile_interval': 0, 14:56:46 INFO - 'installer_path': 'installer.exe', 14:56:46 INFO - 'log_level': 'info', 14:56:46 INFO - 'log_name': 'talos', 14:56:46 INFO - 'log_to_console': True, 14:56:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:56:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:56:46 INFO - 'opt_config_files': (), 14:56:46 INFO - 'pip_index': False, 14:56:46 INFO - 'suite': 'dromaeojs-e10s', 14:56:46 INFO - 'system_bits': '32', 14:56:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:56:46 INFO - 'title': 'talos-linux64-ix-066', 14:56:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:56:46 INFO - 'use_talos_json': True, 14:56:46 INFO - 'verify': 'False', 14:56:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:56:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:56:46 INFO - 'work_dir': 'build'} 14:56:46 INFO - [mozharness: 2017-09-08 21:56:46.583026Z] Running clobber step. 14:56:46 INFO - Running pre-action listener: _resource_record_pre_action 14:56:46 INFO - Running main action method: clobber 14:56:46 INFO - rmtree: /builds/slave/test/build 14:56:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:56:47 INFO - Running post-action listener: _resource_record_post_action 14:56:47 INFO - [mozharness: 2017-09-08 21:56:47.597073Z] Finished clobber step (success) 14:56:47 INFO - [mozharness: 2017-09-08 21:56:47.597170Z] Running read-buildbot-config step. 14:56:47 INFO - Running pre-action listener: _resource_record_pre_action 14:56:47 INFO - Running main action method: read_buildbot_config 14:56:47 INFO - Using buildbot properties: 14:56:47 INFO - { 14:56:47 INFO - "project": "", 14:56:47 INFO - "product": "firefox", 14:56:47 INFO - "who": "kwierso@gmail.com", 14:56:47 INFO - "installer_path": "public/build/target.tar.bz2", 14:56:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:56:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:56:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 14:56:47 INFO - "stage_platform": "linux64-pgo", 14:56:47 INFO - "basedir": "/builds/slave/test", 14:56:47 INFO - "buildnumber": 170, 14:56:47 INFO - "platform": "ubuntu64_hw", 14:56:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:56:47 INFO - "slavebuilddir": "test", 14:56:47 INFO - "taskId": "V-6g_44TSqmJNF8G3mRvAw", 14:56:47 INFO - "branch": "mozilla-central", 14:56:47 INFO - "script_repo_revision": "production", 14:56:47 INFO - "revision": "ea7b55d65d76214f97aaae502d65cb26fc6f5659", 14:56:47 INFO - "slavename": "talos-linux64-ix-066", 14:56:47 INFO - "repo_path": "mozilla-central" 14:56:47 INFO - } 14:56:47 INFO - Finding installer, test and symbols from parent task. 14:56:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-6g_44TSqmJNF8G3mRvAw'}, attempt #1 14:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V-6g_44TSqmJNF8G3mRvAw'}, attempt #1 14:56:48 INFO - Task dependencies: IMdszc27RVGOKwUOJDrcRA 14:56:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA'}, attempt #1 14:56:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 14:56:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.test_packages.json 14:56:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.crashreporter-symbols.zip 14:56:48 INFO - Running post-action listener: _resource_record_post_action 14:56:48 INFO - [mozharness: 2017-09-08 21:56:48.988260Z] Finished read-buildbot-config step (success) 14:56:48 INFO - [mozharness: 2017-09-08 21:56:48.988478Z] Running download-and-extract step. 14:56:48 INFO - Running pre-action listener: _resource_record_pre_action 14:56:48 INFO - Running main action method: download_and_extract 14:56:48 INFO - mkdir: /builds/slave/test/build/tests 14:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:48 INFO - trying https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.test_packages.json 14:56:48 INFO - Downloading https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:56:49 INFO - Downloaded 989 bytes. 14:56:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:56:49 INFO - Using the following test package requirements: 14:56:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:56:49 INFO - u'common': [u'target.common.tests.zip'], 14:56:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:56:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:56:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:56:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:56:49 INFO - u'mozbase': [u'target.common.tests.zip'], 14:56:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:56:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:56:49 INFO - u'web-platform': [u'target.common.tests.zip', 14:56:49 INFO - u'target.web-platform.tests.tar.gz'], 14:56:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:56:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 14:56:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.common.tests.zip 14:56:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:56:49 INFO - Fetch https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.common.tests.zip into memory 14:56:50 INFO - Content-Length response header: 55694934 14:56:50 INFO - Bytes received: 55694934 14:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.talos.tests.zip 14:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.talos.tests.zip into memory 14:57:02 INFO - Content-Length response header: 14497945 14:57:02 INFO - Bytes received: 14497945 14:57: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')]} 14:57:03 INFO - trying https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 14:57:03 INFO - Downloading https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:57:04 INFO - Downloaded 63573495 bytes. 14:57:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 14:57:04 INFO - mkdir: /builds/slave/test/properties 14:57:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:04 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:04 INFO - Contents: 14:57:04 INFO - build_url:https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 14:57:04 INFO - Running post-action listener: _resource_record_post_action 14:57:04 INFO - Running post-action listener: find_tests_for_verification 14:57:04 INFO - Running post-action listener: set_extra_try_arguments 14:57:04 INFO - [mozharness: 2017-09-08 21:57:04.120189Z] Finished download-and-extract step (success) 14:57:04 INFO - [mozharness: 2017-09-08 21:57:04.120296Z] Running populate-webroot step. 14:57:04 INFO - Running pre-action listener: _resource_record_pre_action 14:57:04 INFO - Running main action method: populate_webroot 14:57:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:57:04 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['tresize', 14:57:04 INFO - 'tcanvasmark']}, 14:57:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:57:04 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['dromaeo_css', 14:57:04 INFO - 'kraken']}, 14:57:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:04 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'tests': ['damp', 'tps']}, 14:57:04 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['damp', 'tps']}, 14:57:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:04 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['dromaeo_dom']}, 14:57:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:57:04 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['basic_compositor_video', 14:57:04 INFO - 'glvideo']}, 14:57:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:57:04 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['ts_paint_webext', 14:57:04 INFO - 'tp5o_webext']}, 14:57:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:57:04 INFO - 'ts_paint', 14:57:04 INFO - 'tpaint', 14:57:04 INFO - 'sessionrestore', 14:57:04 INFO - 'sessionrestore_many_windows', 14:57:04 INFO - 'sessionrestore_no_auto_restore', 14:57:04 INFO - 'tabpaint']}, 14:57:04 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['a11yr', 14:57:04 INFO - 'ts_paint', 14:57:04 INFO - 'tpaint', 14:57:04 INFO - 'sessionrestore', 14:57:04 INFO - 'sessionrestore_many_windows', 14:57:04 INFO - 'sessionrestore_no_auto_restore', 14:57:04 INFO - 'tabpaint']}, 14:57:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:57:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:57:04 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['bloom_basic_singleton']}, 14:57:04 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['bloom_basic']}, 14:57:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:57:04 INFO - 'tsvgr_opacity', 14:57:04 INFO - 'tart', 14:57:04 INFO - 'tscrollx', 14:57:04 INFO - 'tsvg_static']}, 14:57:04 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['tsvgx', 14:57:04 INFO - 'tsvgr_opacity', 14:57:04 INFO - 'tart', 14:57:04 INFO - 'tscrollx', 14:57:04 INFO - 'tsvg_static']}, 14:57:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:57:04 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo'], 14:57:04 INFO - 'tests': ['tp5o']}, 14:57:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:57:04 INFO - 'talos_options': ['--mitmproxy', 14:57:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:57:04 INFO - '--firstNonBlankPaint'], 14:57:04 INFO - 'tests': ['tp6_google', 14:57:04 INFO - 'tp6_youtube', 14:57:04 INFO - 'tp6_amazon', 14:57:04 INFO - 'tp6_facebook']}, 14:57:04 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo', 14:57:04 INFO - '--mitmproxy', 14:57:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:57:04 INFO - '--firstNonBlankPaint'], 14:57:04 INFO - 'tests': ['tp6_google', 14:57:04 INFO - 'tp6_youtube', 14:57:04 INFO - 'tp6_amazon', 14:57:04 INFO - 'tp6_facebook']}, 14:57:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:57:04 INFO - 'talos_options': ['--stylo-threads=1', 14:57:04 INFO - '--mitmproxy', 14:57:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:57:04 INFO - '--firstNonBlankPaint'], 14:57:04 INFO - 'tests': ['tp6_google', 14:57:04 INFO - 'tp6_youtube', 14:57:04 INFO - 'tp6_amazon', 14:57:04 INFO - 'tp6_facebook']}, 14:57:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--xperf_path', 14:57:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:04 INFO - 'tests': ['tp5n']}, 14:57:04 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 14:57:04 INFO - 'talos_options': ['--disable-stylo', 14:57:04 INFO - '--xperf_path', 14:57:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:04 INFO - 'tests': ['tp5n']}}} 14:57:04 INFO - Running post-action listener: _resource_record_post_action 14:57:04 INFO - [mozharness: 2017-09-08 21:57:04.143732Z] Finished populate-webroot step (success) 14:57:04 INFO - [mozharness: 2017-09-08 21:57:04.143831Z] Running create-virtualenv step. 14:57:04 INFO - Running pre-action listener: _resource_record_pre_action 14:57:04 INFO - Running main action method: create_virtualenv 14:57:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:57:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 14:57:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:57:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:06 INFO - Installing pip...............done. 14:57:06 INFO - Return code: 0 14:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:57:07 INFO - Reading from file tmpfile_stdout 14:57:07 INFO - Output received: 14:57:07 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 14:57:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:57:07 INFO - Using env: {'DISPLAY': ':0', 14:57:07 INFO - 'HOME': '/home/cltbld', 14:57:07 INFO - 'LANG': 'en_US.UTF-8', 14:57:07 INFO - 'LANGUAGE': 'en_US:en', 14:57:07 INFO - 'LOGNAME': 'cltbld', 14:57:07 INFO - 'MAIL': '/var/mail/cltbld', 14:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:07 INFO - 'MOZ_NO_REMOTE': '1', 14:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:07 INFO - 'NO_EM_RESTART': '1', 14:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:07 INFO - 'PWD': '/builds/slave/test', 14:57:07 INFO - 'SHELL': '/bin/bash', 14:57:07 INFO - 'SHLVL': '1', 14:57:07 INFO - 'TERM': 'linux', 14:57:07 INFO - 'TMOUT': '86400', 14:57:07 INFO - 'USER': 'cltbld', 14:57:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:07 INFO - '_': '/tools/buildbot/bin/python'} 14:57:08 INFO - Ignoring indexes: http://pypi.python.org/simple/ 14:57:08 INFO - Downloading/unpacking pip>=1.5 14:57:08 INFO - Running setup.py egg_info for package pip 14:57:08 INFO - warning: no files found matching 'pip/cacert.pem' 14:57:08 INFO - warning: no files found matching '*.html' under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:57:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:57:08 INFO - Installing collected packages: pip 14:57:08 INFO - Found existing installation: pip 1.1 14:57:08 INFO - Uninstalling pip: 14:57:08 INFO - Successfully uninstalled pip 14:57:08 INFO - Running setup.py install for pip 14:57:08 INFO - warning: no files found matching 'pip/cacert.pem' 14:57:08 INFO - warning: no files found matching '*.html' under directory 'docs' 14:57:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 14:57:08 INFO - no previously-included directories found matching 'docs/_build/_sources' 14:57:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 14:57:08 INFO - Successfully installed pip 14:57:08 INFO - Cleaning up... 14:57:08 INFO - Return code: 0 14:57:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:57: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')]} 14:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57: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')]} 14:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57: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', '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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:57: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 psutil>=3.1.1 14:57:08 INFO - Using env: {'DISPLAY': ':0', 14:57:08 INFO - 'HOME': '/home/cltbld', 14:57:08 INFO - 'LANG': 'en_US.UTF-8', 14:57:08 INFO - 'LANGUAGE': 'en_US:en', 14:57:08 INFO - 'LOGNAME': 'cltbld', 14:57:08 INFO - 'MAIL': '/var/mail/cltbld', 14:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:08 INFO - 'MOZ_NO_REMOTE': '1', 14:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:08 INFO - 'NO_EM_RESTART': '1', 14:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:08 INFO - 'PWD': '/builds/slave/test', 14:57:08 INFO - 'SHELL': '/bin/bash', 14:57:08 INFO - 'SHLVL': '1', 14:57:08 INFO - 'TERM': 'linux', 14:57:08 INFO - 'TMOUT': '86400', 14:57:08 INFO - 'USER': 'cltbld', 14:57:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:08 INFO - '_': '/tools/buildbot/bin/python'} 14:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:09 INFO - Downloading/unpacking psutil>=3.1.1 14:57:09 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 14:57:09 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 14:57:09 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 14:57:09 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 14:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:11 INFO - Installing collected packages: psutil 14:57:11 INFO - Running setup.py install for psutil 14:57:11 INFO - building 'psutil._psutil_linux' extension 14:57:11 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 14:57:13 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 14:57:13 INFO - building 'psutil._psutil_posix' extension 14:57:13 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 14:57:13 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 14:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:13 INFO - Successfully installed psutil 14:57:13 INFO - Cleaning up... 14:57:13 INFO - Return code: 0 14:57:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:57:13 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')]} 14:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:13 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')]} 14:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:13 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:13 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 14:57:13 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 14:57:13 INFO - Using env: {'DISPLAY': ':0', 14:57:13 INFO - 'HOME': '/home/cltbld', 14:57:13 INFO - 'LANG': 'en_US.UTF-8', 14:57:13 INFO - 'LANGUAGE': 'en_US:en', 14:57:13 INFO - 'LOGNAME': 'cltbld', 14:57:13 INFO - 'MAIL': '/var/mail/cltbld', 14:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:13 INFO - 'MOZ_NO_REMOTE': '1', 14:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:13 INFO - 'NO_EM_RESTART': '1', 14:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:13 INFO - 'PWD': '/builds/slave/test', 14:57:13 INFO - 'SHELL': '/bin/bash', 14:57:13 INFO - 'SHLVL': '1', 14:57:13 INFO - 'TERM': 'linux', 14:57:13 INFO - 'TMOUT': '86400', 14:57:13 INFO - 'USER': 'cltbld', 14:57:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:13 INFO - '_': '/tools/buildbot/bin/python'} 14:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:57:13 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 14:57:13 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 14:57:13 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 14:57:13 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 14:57:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:57:14 INFO - Installing collected packages: mozsystemmonitor 14:57:14 INFO - Running setup.py install for mozsystemmonitor 14:57:14 INFO - Successfully installed mozsystemmonitor 14:57:14 INFO - Cleaning up... 14:57:15 INFO - Return code: 0 14:57:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:57:15 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')]} 14:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:15 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')]} 14:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:15 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:15 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 14:57:15 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 14:57:15 INFO - Using env: {'DISPLAY': ':0', 14:57:15 INFO - 'HOME': '/home/cltbld', 14:57:15 INFO - 'LANG': 'en_US.UTF-8', 14:57:15 INFO - 'LANGUAGE': 'en_US:en', 14:57:15 INFO - 'LOGNAME': 'cltbld', 14:57:15 INFO - 'MAIL': '/var/mail/cltbld', 14:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:15 INFO - 'MOZ_NO_REMOTE': '1', 14:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:15 INFO - 'NO_EM_RESTART': '1', 14:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:15 INFO - 'PWD': '/builds/slave/test', 14:57:15 INFO - 'SHELL': '/bin/bash', 14:57:15 INFO - 'SHLVL': '1', 14:57:15 INFO - 'TERM': 'linux', 14:57:15 INFO - 'TMOUT': '86400', 14:57:15 INFO - 'USER': 'cltbld', 14:57:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:15 INFO - '_': '/tools/buildbot/bin/python'} 14:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:15 INFO - Downloading/unpacking jsonschema==2.5.1 14:57:15 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 14:57:15 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 14:57:15 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 14:57:15 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 14:57:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:57:16 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 14:57:16 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 14:57:16 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 14:57:16 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 14:57:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:16 INFO - warning: no files found matching '*.txt' 14:57:16 INFO - no previously-included directories found matching 'build' 14:57:16 INFO - no previously-included directories found matching 'dist' 14:57:16 INFO - no previously-included directories found matching '.git*' 14:57:16 INFO - Installing collected packages: jsonschema, functools32 14:57:16 INFO - Running setup.py install for functools32 14:57:16 INFO - warning: no files found matching '*.txt' 14:57:16 INFO - no previously-included directories found matching 'build' 14:57:16 INFO - no previously-included directories found matching 'dist' 14:57:16 INFO - no previously-included directories found matching '.git*' 14:57:16 INFO - Successfully installed jsonschema functools32 14:57:16 INFO - Cleaning up... 14:57:16 INFO - Return code: 0 14:57:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:57:16 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')]} 14:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:16 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')]} 14:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:16 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:16 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 14:57:16 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 14:57:16 INFO - Using env: {'DISPLAY': ':0', 14:57:16 INFO - 'HOME': '/home/cltbld', 14:57:16 INFO - 'LANG': 'en_US.UTF-8', 14:57:16 INFO - 'LANGUAGE': 'en_US:en', 14:57:16 INFO - 'LOGNAME': 'cltbld', 14:57:16 INFO - 'MAIL': '/var/mail/cltbld', 14:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:16 INFO - 'MOZ_NO_REMOTE': '1', 14:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:16 INFO - 'NO_EM_RESTART': '1', 14:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:16 INFO - 'PWD': '/builds/slave/test', 14:57:16 INFO - 'SHELL': '/bin/bash', 14:57:16 INFO - 'SHLVL': '1', 14:57:16 INFO - 'TERM': 'linux', 14:57:16 INFO - 'TMOUT': '86400', 14:57:16 INFO - 'USER': 'cltbld', 14:57:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:16 INFO - '_': '/tools/buildbot/bin/python'} 14:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:57:16 INFO - Cleaning up... 14:57:16 INFO - Return code: 0 14:57:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57:16 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')]} 14:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:16 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')]} 14:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:16 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:16 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 14:57:16 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 14:57:16 INFO - Using env: {'DISPLAY': ':0', 14:57:16 INFO - 'HOME': '/home/cltbld', 14:57:16 INFO - 'LANG': 'en_US.UTF-8', 14:57:16 INFO - 'LANGUAGE': 'en_US:en', 14:57:16 INFO - 'LOGNAME': 'cltbld', 14:57:16 INFO - 'MAIL': '/var/mail/cltbld', 14:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:16 INFO - 'MOZ_NO_REMOTE': '1', 14:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:16 INFO - 'NO_EM_RESTART': '1', 14:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:16 INFO - 'PWD': '/builds/slave/test', 14:57:16 INFO - 'SHELL': '/bin/bash', 14:57:16 INFO - 'SHLVL': '1', 14:57:16 INFO - 'TERM': 'linux', 14:57:16 INFO - 'TMOUT': '86400', 14:57:16 INFO - 'USER': 'cltbld', 14:57:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:16 INFO - '_': '/tools/buildbot/bin/python'} 14:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:17 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:17 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 14:57:17 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 14:57:17 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 14:57:17 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 14:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:18 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 14:57:18 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 14:57:18 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 14:57:18 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 14:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:18 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 14:57:18 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 14:57:18 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 14:57:18 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 14:57:18 INFO - Downloading docopt-0.6.1.tar.gz 14:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:18 INFO - Running setup.py install for blobuploader 14:57:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:19 INFO - Running setup.py install for requests 14:57:19 INFO - Running setup.py install for docopt 14:57:19 INFO - Successfully installed blobuploader requests docopt 14:57:19 INFO - Cleaning up... 14:57:19 INFO - Return code: 0 14:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:19 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:19 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 14:57:19 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 14:57:19 INFO - Using env: {'DISPLAY': ':0', 14:57:19 INFO - 'HOME': '/home/cltbld', 14:57:19 INFO - 'LANG': 'en_US.UTF-8', 14:57:19 INFO - 'LANGUAGE': 'en_US:en', 14:57:19 INFO - 'LOGNAME': 'cltbld', 14:57:19 INFO - 'MAIL': '/var/mail/cltbld', 14:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:19 INFO - 'MOZ_NO_REMOTE': '1', 14:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:19 INFO - 'NO_EM_RESTART': '1', 14:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:19 INFO - 'PWD': '/builds/slave/test', 14:57:19 INFO - 'SHELL': '/bin/bash', 14:57:19 INFO - 'SHLVL': '1', 14:57:19 INFO - 'TERM': 'linux', 14:57:19 INFO - 'TMOUT': '86400', 14:57:19 INFO - 'USER': 'cltbld', 14:57:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:19 INFO - '_': '/tools/buildbot/bin/python'} 14:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:19 INFO - Running setup.py (path:/tmp/pip-dFxOCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:19 INFO - Running setup.py (path:/tmp/pip-Y0uF0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:19 INFO - Running setup.py (path:/tmp/pip-aWq2ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:19 INFO - Running setup.py (path:/tmp/pip-98nkh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:19 INFO - Running setup.py (path:/tmp/pip-QzrIiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:20 INFO - Running setup.py (path:/tmp/pip-98NXWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:20 INFO - Running setup.py (path:/tmp/pip-Mnu1jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:20 INFO - Running setup.py (path:/tmp/pip-yDOpyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:20 INFO - Running setup.py (path:/tmp/pip-VpguE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:20 INFO - Running setup.py (path:/tmp/pip-NB1UNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:20 INFO - Running setup.py (path:/tmp/pip-Ai8Hki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:20 INFO - Running setup.py (path:/tmp/pip-cYr7S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:20 INFO - Running setup.py (path:/tmp/pip-zM_z7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:20 INFO - Running setup.py (path:/tmp/pip-RWiY_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:20 INFO - Running setup.py (path:/tmp/pip-fbDiaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:20 INFO - Running setup.py (path:/tmp/pip-Jz9w7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:20 INFO - Running setup.py (path:/tmp/pip-f5dF5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:20 INFO - Running setup.py install for manifestparser 14:57:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:20 INFO - Running setup.py install for mozcrash 14:57:21 INFO - Running setup.py install for mozdebug 14:57:21 INFO - Running setup.py install for mozdevice 14:57:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for mozfile 14:57:21 INFO - Running setup.py install for mozhttpd 14:57:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for mozinfo 14:57:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for mozInstall 14:57:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for mozleak 14:57:21 INFO - Running setup.py install for mozlog 14:57:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for moznetwork 14:57:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:21 INFO - Running setup.py install for mozprocess 14:57:22 INFO - Running setup.py install for mozprofile 14:57:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:22 INFO - Running setup.py install for mozrunner 14:57:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:22 INFO - Running setup.py install for mozscreenshot 14:57:22 INFO - Running setup.py install for moztest 14:57:22 INFO - Running setup.py install for mozversion 14:57:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:22 INFO - Cleaning up... 14:57:22 INFO - Return code: 0 14:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:22 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')]} 14:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:22 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')]} 14:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:22 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:22 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 14:57:22 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 14:57:22 INFO - Using env: {'DISPLAY': ':0', 14:57:22 INFO - 'HOME': '/home/cltbld', 14:57:22 INFO - 'LANG': 'en_US.UTF-8', 14:57:22 INFO - 'LANGUAGE': 'en_US:en', 14:57:22 INFO - 'LOGNAME': 'cltbld', 14:57:22 INFO - 'MAIL': '/var/mail/cltbld', 14:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:22 INFO - 'MOZ_NO_REMOTE': '1', 14:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:22 INFO - 'NO_EM_RESTART': '1', 14:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:22 INFO - 'PWD': '/builds/slave/test', 14:57:22 INFO - 'SHELL': '/bin/bash', 14:57:22 INFO - 'SHLVL': '1', 14:57:22 INFO - 'TERM': 'linux', 14:57:22 INFO - 'TMOUT': '86400', 14:57:22 INFO - 'USER': 'cltbld', 14:57:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:22 INFO - '_': '/tools/buildbot/bin/python'} 14:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:22 INFO - Running setup.py (path:/tmp/pip-gAfJek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:22 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)) 14:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:22 INFO - Running setup.py (path:/tmp/pip-tL1JnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:22 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)) 14:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:22 INFO - Running setup.py (path:/tmp/pip-bhTjWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:23 INFO - Running setup.py (path:/tmp/pip-Akqx5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:23 INFO - Running setup.py (path:/tmp/pip-PC778g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:23 INFO - Running setup.py (path:/tmp/pip-nOc9VD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:23 INFO - Running setup.py (path:/tmp/pip-9WR2wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:23 INFO - Running setup.py (path:/tmp/pip-G6TzYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:23 INFO - Running setup.py (path:/tmp/pip-j_iitH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:23 INFO - Running setup.py (path:/tmp/pip-tG7xJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:23 INFO - Running setup.py (path:/tmp/pip-aQBo8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:23 INFO - Running setup.py (path:/tmp/pip-4UiSOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:23 INFO - Running setup.py (path:/tmp/pip-gAep9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:23 INFO - Running setup.py (path:/tmp/pip-eUUL8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:23 INFO - Running setup.py (path:/tmp/pip-jE1WKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:23 INFO - Running setup.py (path:/tmp/pip-be9Q9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:23 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)) 14:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:23 INFO - Running setup.py (path:/tmp/pip-pHAleT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:23 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)) 14:57:23 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)) 14:57:23 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)) 14:57:23 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)) 14:57:23 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)) 14:57:23 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)) 14:57:23 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)) 14:57:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:23 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 14:57:23 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 14:57:23 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 14:57:23 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 14:57:25 INFO - Downloading blessings-1.6.tar.gz 14:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:25 INFO - Installing collected packages: blessings 14:57:25 INFO - Running setup.py install for blessings 14:57:25 INFO - Successfully installed blessings 14:57:25 INFO - Cleaning up... 14:57:25 INFO - Return code: 0 14:57:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:25 INFO - Reading from file tmpfile_stdout 14:57:25 INFO - Current package versions: 14:57:25 INFO - argparse == 1.2.1 14:57:25 INFO - blessings == 1.6 14:57:25 INFO - blobuploader == 1.2.4 14:57:25 INFO - docopt == 0.6.1 14:57:25 INFO - functools32 == 3.2.3-2 14:57:25 INFO - jsonschema == 2.5.1 14:57:25 INFO - manifestparser == 1.1 14:57:25 INFO - mozInstall == 1.13 14:57:25 INFO - mozcrash == 1.0 14:57:25 INFO - mozdebug == 0.1 14:57:25 INFO - mozdevice == 0.51 14:57:25 INFO - mozfile == 1.2 14:57:25 INFO - mozhttpd == 0.7 14:57:25 INFO - mozinfo == 0.10 14:57:25 INFO - mozleak == 0.1 14:57:25 INFO - mozlog == 3.5 14:57:25 INFO - moznetwork == 0.27 14:57:25 INFO - mozprocess == 0.25 14:57:25 INFO - mozprofile == 0.28 14:57:25 INFO - mozrunner == 6.13 14:57:25 INFO - mozscreenshot == 0.1 14:57:25 INFO - mozsystemmonitor == 0.3 14:57:25 INFO - moztest == 0.8 14:57:25 INFO - mozversion == 1.4 14:57:25 INFO - psutil == 3.1.1 14:57:25 INFO - requests == 1.2.3 14:57:25 INFO - wsgiref == 0.1.2 14:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:25 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:25 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 14:57:25 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 14:57:25 INFO - Using env: {'DISPLAY': ':0', 14:57:25 INFO - 'HOME': '/home/cltbld', 14:57:25 INFO - 'LANG': 'en_US.UTF-8', 14:57:25 INFO - 'LANGUAGE': 'en_US:en', 14:57:25 INFO - 'LOGNAME': 'cltbld', 14:57:25 INFO - 'MAIL': '/var/mail/cltbld', 14:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:25 INFO - 'MOZ_NO_REMOTE': '1', 14:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:25 INFO - 'NO_EM_RESTART': '1', 14:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:25 INFO - 'PWD': '/builds/slave/test', 14:57:25 INFO - 'SHELL': '/bin/bash', 14:57:25 INFO - 'SHLVL': '1', 14:57:25 INFO - 'TERM': 'linux', 14:57:25 INFO - 'TMOUT': '86400', 14:57:25 INFO - 'USER': 'cltbld', 14:57:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:25 INFO - '_': '/tools/buildbot/bin/python'} 14:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 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)) 14:57:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:57:25 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 14:57:25 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 14:57:25 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 14:57:25 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 14:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:57:27 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)) 14:57:27 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)) 14:57:27 INFO - Installing collected packages: simplejson 14:57:27 INFO - Running setup.py install for simplejson 14:57:27 INFO - building 'simplejson._speedups' extension 14:57:27 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 14:57:27 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 14:57:28 INFO - Successfully installed simplejson 14:57:28 INFO - Cleaning up... 14:57:28 INFO - Return code: 0 14:57:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:28 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 0x15921f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, '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': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', '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 14:57:28 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 14:57:28 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 14:57:28 INFO - Using env: {'DISPLAY': ':0', 14:57:28 INFO - 'HOME': '/home/cltbld', 14:57:28 INFO - 'LANG': 'en_US.UTF-8', 14:57:28 INFO - 'LANGUAGE': 'en_US:en', 14:57:28 INFO - 'LOGNAME': 'cltbld', 14:57:28 INFO - 'MAIL': '/var/mail/cltbld', 14:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:28 INFO - 'MOZ_NO_REMOTE': '1', 14:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:28 INFO - 'NO_EM_RESTART': '1', 14:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:28 INFO - 'PWD': '/builds/slave/test', 14:57:28 INFO - 'SHELL': '/bin/bash', 14:57:28 INFO - 'SHLVL': '1', 14:57:28 INFO - 'TERM': 'linux', 14:57:28 INFO - 'TMOUT': '86400', 14:57:28 INFO - 'USER': 'cltbld', 14:57:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:28 INFO - '_': '/tools/buildbot/bin/python'} 14:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:57:28 INFO - Cleaning up... 14:57:28 INFO - Return code: 0 14:57:28 INFO - Running post-action listener: _resource_record_post_action 14:57:28 INFO - Running post-action listener: _start_resource_monitoring 14:57:28 INFO - Starting resource monitoring. 14:57:28 INFO - [mozharness: 2017-09-08 21:57:28.415280Z] Finished create-virtualenv step (success) 14:57:28 INFO - [mozharness: 2017-09-08 21:57:28.416325Z] Running install step. 14:57:28 INFO - Running pre-action listener: _resource_record_pre_action 14:57:28 INFO - Running main action method: install 14:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:28 INFO - Reading from file tmpfile_stdout 14:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:28 INFO - Reading from file tmpfile_stdout 14:57:28 INFO - Output received: 14:57:28 INFO - Usage: mozinstall [options] installer 14:57:28 INFO - Options: 14:57:28 INFO - -h, --help show this help message and exit 14:57:28 INFO - -d DEST, --destination=DEST 14:57:28 INFO - Directory to install application into. [default: 14:57:28 INFO - "/builds/slave/test"] 14:57:28 INFO - --app=APP Application being installed. [default: firefox] 14:57:28 INFO - mkdir: /builds/slave/test/build/application 14:57:28 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'] 14:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:57:45 INFO - Reading from file tmpfile_stdout 14:57:45 INFO - Output received: 14:57:45 INFO - /builds/slave/test/build/application/firefox/firefox 14:57:45 INFO - Running post-action listener: _resource_record_post_action 14:57:45 INFO - [mozharness: 2017-09-08 21:57:45.127665Z] Finished install step (success) 14:57:45 INFO - [mozharness: 2017-09-08 21:57:45.127917Z] Running setup-mitmproxy step. 14:57:45 INFO - Running pre-action listener: _resource_record_pre_action 14:57:45 INFO - Running main action method: setup_mitmproxy 14:57:45 INFO - Skipping: mitmproxy is not required 14:57:45 INFO - Running post-action listener: _resource_record_post_action 14:57:45 INFO - [mozharness: 2017-09-08 21:57:45.129030Z] Finished setup-mitmproxy step (success) 14:57:45 INFO - [mozharness: 2017-09-08 21:57:45.129249Z] Running run-tests step. 14:57:45 INFO - Running pre-action listener: _resource_record_pre_action 14:57:45 INFO - Running pre-action listener: _set_gcov_prefix 14:57:45 INFO - Running main action method: run_tests 14:57:45 WARNING - Try message not found. 14:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:57:45 INFO - Python 2.7.3 14:57:45 INFO - Return code: 0 14:57:45 INFO - grabbing minidump binary from tooltool 14:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:57:45 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 0x1902090>, '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 0x1902d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fcf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:57:45 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 14:57:45 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 14:57:45 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 14:57:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:57:45 INFO - Return code: 0 14:57:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:57:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:57:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:57:45 INFO - ENV: RUST_BACKTRACE is now full 14:57:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:57:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:57:45 INFO - Using env: {'DISPLAY': ':0', 14:57:45 INFO - 'HOME': '/home/cltbld', 14:57:45 INFO - 'LANG': 'en_US.UTF-8', 14:57:45 INFO - 'LANGUAGE': 'en_US:en', 14:57:45 INFO - 'LOGNAME': 'cltbld', 14:57:45 INFO - 'MAIL': '/var/mail/cltbld', 14:57:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:57:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:45 INFO - 'MOZ_NO_REMOTE': '1', 14:57:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:45 INFO - 'NO_EM_RESTART': '1', 14:57:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:45 INFO - 'PWD': '/builds/slave/test', 14:57:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:57:45 INFO - 'RUST_BACKTRACE': 'full', 14:57:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:57:45 INFO - 'SHELL': '/bin/bash', 14:57:45 INFO - 'SHLVL': '1', 14:57:45 INFO - 'TERM': 'linux', 14:57:45 INFO - 'TMOUT': '86400', 14:57:45 INFO - 'USER': 'cltbld', 14:57:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:45 INFO - '_': '/tools/buildbot/bin/python'} 14:57:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:57:45 INFO - mozversion application_buildid: 20170908203646 14:57:45 INFO - mozversion application_changeset: ea7b55d65d76214f97aaae502d65cb26fc6f5659 14:57:45 INFO - mozversion application_display_name: Nightly 14:57:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:57:45 INFO - mozversion application_name: Firefox 14:57:45 INFO - mozversion application_remotingname: firefox 14:57:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:57:45 INFO - mozversion application_vendor: Mozilla 14:57:45 INFO - mozversion application_version: 57.0a1 14:57:45 INFO - mozversion platform_buildid: 20170908203646 14:57:45 INFO - mozversion platform_changeset: ea7b55d65d76214f97aaae502d65cb26fc6f5659 14:57:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:57:45 INFO - mozversion platform_version: 57.0a1 14:57:45 INFO - using testdate: 1504907865 14:57:45 INFO - actual date: 1504907865 14:57:45 INFO - starting webserver on 'localhost:42435' 14:57:45 INFO - SUITE-START | Running 2 tests 14:57:45 INFO - TEST-START | dromaeo_css 14:57:45 INFO - Initialising browser for dromaeo_css test... 14:57:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42435/getInfo.html -profile /tmp/tmpwx1tnA/profile 14:57:45 INFO - TEST-INFO | started process 3604 (/builds/slave/test/build/application/firefox/firefox http://localhost:42435/getInfo.html) 14:57:55 INFO - TEST-INFO | 3604: exit 0 14:57:55 INFO - Browser initialized. 14:57:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:57:55 INFO - Using env: {'DISPLAY': ':0', 14:57:55 INFO - 'HOME': '/home/cltbld', 14:57:55 INFO - 'JSGC_DISABLE_POISONING': '1', 14:57:55 INFO - 'LANG': 'en_US.UTF-8', 14:57:55 INFO - 'LANGUAGE': 'en_US:en', 14:57:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 14:57:55 INFO - 'LOGNAME': 'cltbld', 14:57:55 INFO - 'MAIL': '/var/mail/cltbld', 14:57:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:57:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:57:55 INFO - 'MOZ_CRASHREPORTER': '1', 14:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 14:57:55 INFO - 'MOZ_NO_REMOTE': '1', 14:57:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:55 INFO - 'NO_EM_RESTART': '1', 14:57:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:55 INFO - 'PWD': '/builds/slave/test', 14:57:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:57:55 INFO - 'RUST_BACKTRACE': 'full', 14:57:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:57:55 INFO - 'SHELL': '/bin/bash', 14:57:55 INFO - 'SHLVL': '1', 14:57:55 INFO - 'TERM': 'linux', 14:57:55 INFO - 'TMOUT': '86400', 14:57:55 INFO - 'USER': 'cltbld', 14:57:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 14:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:55 INFO - '_': '/tools/buildbot/bin/python'} 14:57:55 INFO - TEST-INFO | started process 3807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwx1tnA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:56 INFO - PID 3807 | 14:57:56 INFO - PID 3807 | (/builds/slave/test/build/application/firefox/firefox:3858): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:57:56 INFO - PID 3807 | 14:58:06 INFO - PID 3807 | RSS: Main: 164941824 14:58:06 INFO - PID 3807 | 15:01:02 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42435/tests/dromaeo/cssquery-ext.html) 15:01:03 INFO - PID 3807 | RSS: Main: 167247872 15:01:03 INFO - PID 3807 | 15:04:05 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-ext.html (next: http://localhost:42435/tests/dromaeo/cssquery-jquery.html) 15:04:06 INFO - PID 3807 | RSS: Main: 163368960 15:04:06 INFO - PID 3807 | 15:07:07 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42435/tests/dromaeo/cssquery-mootools.html) 15:07:08 INFO - PID 3807 | RSS: Main: 165900288 15:07:08 INFO - PID 3807 | 15:10:09 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42435/tests/dromaeo/cssquery-prototype.html) 15:10:10 INFO - PID 3807 | RSS: Main: 164925440 15:10:10 INFO - PID 3807 | 15:13:13 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42435/tests/dromaeo/cssquery-yui.html) 15:13:14 INFO - PID 3807 | RSS: Main: 165990400 15:13:14 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | Cycle 1(1): loaded http://localhost:42435/tests/dromaeo/cssquery-yui.html (next: http://localhost:42435/tests/dromaeo/cssquery-dojo.html) 15:16:15 INFO - PID 3807 | RSS: Main: 168448000 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | __start_tp_report 15:16:15 INFO - PID 3807 | _x_x_mozilla_page_load 15:16:15 INFO - PID 3807 | _x_x_mozilla_page_load_details 15:16:15 INFO - PID 3807 | |i|pagename|runs| 15:16:15 INFO - PID 3807 | |0;dojo.html;3850.460935469033;3852.672522835559;3863.227354529095;3873.8256778444975;3893.0851249956254;6137.539684523656;6219.657918814463;6244.937550624492;6252.155958945541;6342.556021078526;6148.047052706837;6209.410106039931;6238.500919926406;6362.809115726535;6388.361163883609;5545.694986775726;5642.520385767215;5663.631863928852;5673.404292549285;5676.971615141919;301.31640080532753;5280.498352656491;5519.586031047667;5604.579656525756;5621.634593751393;5534.197541356501;5546.55627549795;5608.915866262009;5614.494695477386;5631.099024156136;5536.557075433956;5555.111182210867;5608.915866262009;5611.551075913917;5618.494335509824;5493.176023596453;5568.49883510482;5584.692841893694;5590.524805391547;5665.065264231397;6125.234345706786;6182.412670796312;6220.440160385587;6259;6262.749490020394;6619.801405957829;6622.9006564901565;6624.53628246023;6704.497162712767;6782.694778734969;6762.289959554274;6794.490413219029;6891.345322194434;6900.3099690031095;6920.065791118185;6205.658688772116;6291.213598300213;6315.24217093947;6364.77723279683;6406.455451286646;6952.582845029315;6962.512624116364;6965.094537710065;7022.754203602952;7052.365287124081;6562;6667.466602671775;6674.866502669919;6678.3989440950545;6684.532082754258;6679.031540426611;6708.765193218214;6714.832129196711;6728.125343705287;6811.4210292124735;6605.471562275103;6729.0915726376315;6739.460843132538;6746.089277947414;6749.190097188369;6668.533202675766;6689.063531105649;6738.056672065914;6759.188897332351;6779.796606101825;4857.125717370907;4962.950370496249;4972.825951091694;4973.452920178777;4999.525045120708;4456.286994080931;4461.910761784746;4478.373027776114;4488.730676159441;4522.253828118323;6100.664463454553;6148.815535533941;6189.35011823752;6219.689015549295;6292.905606415908;6750.3249675033085;6772.627505487246;6794;6809.489288303397;6811.829704257334;6125.326214116443;6219.595726277868;6256.937430625727;6277.843053923689;6288.811335659938;5393.568514518829;5464.043792336325;5467.781288748485;5506.366767821672;5531.9723401382735;6932.514723969273;7000.859982800315;7008.894866577006;7034.964825175842;7040.718371265194;6740.325967403221;6763.222229443677;6829.248782633907;6855.7600483983815;6861.142357205349;6800.455963523005;6838.794836154923;6937.930620693728;6939.4448444125355;7025.508214424941;6627.37039981201;6654.334566543307;6665.700043497957;6674.566153200027;6678.899816502659;6855.451563874978;6868.862622747617;6886.931130688629;6896.137982752156;6904.930950690429;6450.645214513247;6552.901706474502;6572.244191917991;6628.668566571556;6645.6677166140535;6509.349065093642;6511.218653761579;6613.735450581923;6622.933770662425;6627.602343859384;6473.352664733489;6478.805635830932;6557.803265902031;6558.147440832661;6563.409293163638;6504.674766261763;6570.704318305783;6612.669366531558;6707.463402927657;6709.7651582194385;6367.554271200971;6474.449671777763;6477.093206950936;6478.740850366121;6482.805515834532 15:16:15 INFO - PID 3807 | |1;ext.html;933.7012156110047;952.1620973543282;978.124578502241;979.1236843025492;982.5578489679641;43430.78284608576;45107.77446112769;45118.323225151566;45128.54871451284;45132;41974.37038444426;42457.57542424575;44958.32562511565;45879.54120458794;46046.309305360446;7880.014998125234;7990.4806187597915;8006.759797206093;8013.799655008613;8021.879671804928;7820.45256832022;7825.37397008238;7839.686412543491;7870.527768333918;7872.645730942093;7910.644021019068;7915.12933577306;7933.246341597568;7942.9602851985655;7946.562939038351;7845.490043147234;7885;7889.723859664884;7905.367570594367;7926.801829954268;7955.4828936118965;8003.079645840745;8006.3995200360205;8018.278354948083;8027.076886158108;41368.172636547104;41703;41725;41857.37213941793;41859.372109418386;3669.6697297243377;3708.647678470541;3714.461403096563;3720.720945929066;3722.758020728671;34021.319573608635;34024.82987585046;34047.659523404946;34162;34202.315953681034;5548.334199895998;5555.194496797942;5573.804916827891;5584.972075139639;5607.102863541813;210979;214033;223006;223110;241867;53353.46646533562;53804.730976344865;53925.1911221332;54108.188377174374;54121.72939135279;56658.43341566614;56722.149167762516;56784;56885.715571422705;56962.145567816515;16898;17078.48764537066;17084.658306833793;17094.91452542729;17231;14088.506902258578;14090.647733806736;14093.859061409255;14110.294485275695;14128.293585320693;13884.305784710725;13982.161070335813;13984.160950343012;14029.859701402855;14133.575992720234;5775.913361299584;5780.710964451845;5784.971075144597;5824.737886795105;5937.317208520989;1092.208149091918;1094.0973696700255;1094.1137678480457;1107.8061339265596;1113.437713954464;25329.240122796346;25398.492030159294;25443.36391590188;25453.3636659085;25498;1190.571394298052;1193.9731830625656;1198.0714945916984;1204.9096317776202;1212.921160124589;13191.80212296797;13551.254680992442;13575.253361065235;13627.727445451035;13644.386002629706;275077;275109;275891;276337;281503;57821.421785781604;57893;57895.71052144712;58031;58108.709456453296;1474.4544518527998;1480.851914808532;1499.137995652504;1513.674559969612;1544;24765.26114541605;24810.875945620155;24818.246187906756;24868.37829054288;24876.12933547317;38632;40038.19923601453;40154.59845401509;40233.59766402416;40252.39621405623;226749.8662506677;226764;226895;227729;228331;34277.31445371128;34839.30321393609;35575.82212088923;36872.26255474929;37245.813770930974;47621.76189119032;47739.28391074067;47977;48056;48291.517084830106;35380.46929296114;35463;35823.28353432865;36018.91943241707;36155.457668135525;35340.823295883354;35468.82265588656;35518.64481355153;35570.288594228485;36146.27707445889;39335.40996885106;40362.59637403706;40627.390589141774;40714.59285407227;41148.588514114475;33992.490112648826;34095;34243;34439;34696;25790.484190315714;25831;26035.609465858408;26288.079917202806;26299.60550591781 15:16:15 INFO - PID 3807 | |2;jquery.html;591.7455494137522;601.0839381429985;605.839816750922;613.9907901381478;620.4601996263251;23398.64902026471;23965.161219357327;24149.275521734377;24153.63769543454;24165.15421960232;24559.877200614017;27218.31954201146;27428.314292142655;27460.313492162706;27520.862395687993;6867.347601977829;6891.793246202622;6896.965515172442;6899.034135221048;6926.238113807477;6698.196216454008;6842.281560436132;6912.758053468129;6942.652867356637;6955.791326260221;6895.5173137880365;6904.1714994200765;6907.0675458813175;6912.896306555405;6913.204981427125;6662.666866656697;6889.586624802528;6890.862182756367;6901.344372284625;6907.585544867299;6391.45672617828;6409.166808314936;6420.101185833987;6425.742970281183;6427.87144257117;31320.53019204714;31886.681133188602;31896.681033189834;31899.840500797578;31954.680453195404;2262.2534563593977;2294.4608017115966;2296.6784650148993;2297.1385730351117;2299.218265789623;21035.474113147142;21411.35765927025;21508;21532.784672153233;21550.245741398976;2269.137727663494;2273.4430064634107;2301.493671392291;2301.79283864453;2314.7916687498036;140351;147553;158881;164326.17836910978;164522;15874.444394446138;16701.58246043834;16707.66584668324;16831.74752378715;16898.40855570074;25953.870230648725;25979.870100649754;25986;26028.73971260263;26050;10840.945795270973;10881.891181088246;10913.181511386678;10932;10982.890171098186;10001.699949001542;10075.848862267072;10100.343477673927;10121.746956326151;10213.591456341812;10029.598816047277;10130.645427410005;10241.129503992095;10349.534270957674;10353.63762268317;2806.8035237533586;2837.6311079559937;2841.4317136572768;2852.5293326601295;2909.3163106669917;1003.1322905686528;1003.4029752297372;1015.6943737715345;1023.518946095334;1025.7538190834296;21311.36065918025;21813.67279490809;21861.234856780255;21913.233036843634;21936.89031554864;1076.1229597877705;1078.665613659768;1089.5641743302583;1102.2394547762178;1104.6244276945715;11558.711032224093;11625.941870290764;11724.296542207494;11798.233114847508;11896;610856;618798;621559;627438;632265;122339;129007.35496322458;129922;131598;133011;1217.287886586357;1223.2049168040667;1238.789405801016;1250.7123361626877;1258.6979125009932;19103.235870565022;19173.233070677576;19222.8077719221;19312.710309345654;19319.517012074248;61872;62520;62827;63359;64303.67848160729;75064;78902;80621;80660.59669701614;80955.59522202352;15437.691246175238;15596.220188990732;15776.842231577537;15792.92103539475;15806.525804225892;24478.817753691907;24499.510009800062;24686.382840429134;24829.627555586318;24835.50328993374;19643.70534441956;20071.29750458727;20090.397288080796;20259.69610455815;20347.389578312675;17023.148842558072;17162.828371716623;17436;17932.372366967094;17973.820261797213;20248.797512024692;20407.8979605101;20506.692399614316;20774.1690332385;20803.47991300169;15433.5369938902;15458.613534661274;15506.147161906203;15508.302126404113;15513.379464821732;19744.853580748204;19786;20003.59992800165;20045.899770501055;20315.187392504133 15:16:15 INFO - PID 3807 | |3;mootools.html;1368.1038919507723;1429.7212043651487;1441.8990670653052;1456.6504039030635;1457.1475686723259;16551;17116.572085697862;17143.657126857455;17177.914110429447;17189.914050429732;16661.416850410238;16814.747778783327;16826.915865420688;16832.495025149234;16852.747208791847;2711.4441539484405;2822.8165169264034;2823.378856651533;2829.038127036807;2831.348789778352;2740.9588856167175;2823.026056010683;2826.802123851331;2829.7877659175642;2832.773378129755;2817.8450185239803;2904.2013446302226;2909.563565465176;2909.8545072746383;2910.4761142994253;2770.6536682914734;2785.5960885671566;2794.5389010813396;2794.930126746827;2803.1310293808983;2822.520171570838;2826.053272153831;2840.8437535935514;2841.8863245470156;2843.8293702377923;16458.83541164585;16570.420035298826;16649.500514984447;16760.748588771177;16763.329466821313;8113.472624279403;8431.915680843174;8458.74623761288;8475.618597163142;8487.193716596976;5366.4633536646415;5478.58910581704;5508.614396992212;5521.033819081645;5529.281193444866;2114;2132.125828410344;2149.108120130144;2194.089452877054;2204.9779502204933;30139.849300753576;30432.695673043207;30453.23866903345;30500.389992200253;30505.38989220203;7016.473764467685;7087.92912070883;7095.077639906883;7174.390176834923;7262.564246145248;19344;19423;19435.416937491897;19441.222351105796;19450.124744386252;8299.087100418948;8468.068512463624;8477.194666506672;8478.067412584734;8482.151784821592;7558.470907036454;7616.504927179715;7756.340711039625;7769.883451748228;7771.378289736807;5521.668699878021;5656.6888821115235;5665.745041473144;5698.401667824902;5707.3721890592005;1477.1506383829342;1531.4257153567412;1607.172306262276;1620.8136064352514;1668.5161303222174;892.5314210039782;905.3255324782947;910.4491782471641;912.2792993535033;919.852823548229;7880;7972.123066462685;8011.078725946474;8029.8394032120195;8045.436819422701;988.6342053440274;990.1633120013577;993.7863359377624;999.160705007797;1002.8395456727035;4705.8352957647;4766.6901651392545;4780.402449693788;4810.831620893252;4900.6814557054395;24051.879740601184;24116.63825042626;24694.13570525023;24972.37569060788;24982.375440613767;23888.52222955531;24255.151069712476;24556.263312100666;24675;24763.752362476505;12434.62696119118;12521.311327877054;12685.746285074432;12689.175203611736;12713.809292860615;8411.747647570583;8509.74470765878;8554.144585541644;8593.31253499731;8625.568721564023;20664.896675516527;21064.05211765505;21134.788652113897;21472.141114355876;21499;21206.787932121097;21745.782542174376;22169.77830221677;22253.221137260767;22663.773362266165;11983.221090629082;12136.211146275464;12233.69415764613;12263.570775023189;12296;15167.848321516643;15556.144412057445;15559.533214003599;15564.766528502309;15586.06483610987;12047.216930899463;12086.093542984136;12095;12197.878021220029;12365.381730913597;12207.755844882875;12219.45012474423;12278.386080695751;12280.508779648713;12545.811812822632;9823.263255256028;9837;9874.851877221703;9900.702978910644;9986.60053597848;7810.687572497037;7837.882431763414;7943.285104340406;7946.523208607502;7976.6410511525955;7864.960675196817;8009.359251260002;8013.519188848688;8043.758687239392;8168.673253070048 15:16:15 INFO - PID 3807 | |4;prototype.html;514.6397521734787;528.6748649580508;549.8377978496343;550.2736387967884;573.744683615791;6259.749610015594;6268.4671802896755;6351.396617321353;6355.71399287032;6382.361763823616;6256.781012664557;6264.937350626492;6293.395184228027;6303.077561343788;6345.716641267138;5038;5048.570871475929;5111.539961403473;5121.820736274231;5141.228815677641;4956.7025978441225;4971.751412429382;4991.126552853254;5009;5016.197408414654;4934.185859333224;4949.727764972925;4955;4972.229304457796;4995.150824359867;4928.236123400879;4949.8020079196785;4975.651704380694;4995.275685025687;5025.698458092526;4617.561331673485;4628.940121645869;4640.5127461616385;4650.930236046428;4659.953400465985;6087.847803804896;6119.5104391648565;6139.732885644479;6186.257649082094;6235.906461403082;5840.445157710011;5851.531877449794;5893.322267939199;5901.144334071536;5940.6435613863305;6607.30623284553;6626.668666566652;6671.432928201109;6684.16447944007;6694.422647280783;5058.367704036996;5100.948990510122;5122.154844450662;5128.897287083295;5142.840007196986;6868.7252509899545;6878.55289406187;6887.140472072562;6987.196472405637;7020.192677842062;5493.599132221258;5516.841463292753;5537.640053396516;5544.556435485232;5552.944470555323;5605.467480589337;5630.74661640219;5631.211630371751;5635.098384258499;5647;5999.480218308321;6068.726907289182;6089.725962331617;6090.604110732788;6114.724837382329;6675.0988616537115;6713.6643167842385;6724.848048624491;6751.493637977073;6787;1928.0359820089955;1930.5366711989022;1932.5651728361006;1936.1093896807627;1965.1648049579157;1401.8878489720798;1449.1667291307328;1462.1665650579068;1475.5057055886398;1495.1029382370707;5976.432238937294;6190.721417536221;6202.689865506707;6219.191505104308;6241.126242326078;6545.607263564201;6635.6350400728425;6666.500012499082;6732.057511948331;6795.626240556718;6093.847653808691;6106.6336019838955;6132.233470816148;6148.661823599656;6184.969075154595;3529.8588056477965;3549.982250088785;3571.160777217352;3577.5349204603754;3603.8558457661925;6994.055802466602;7004.579725216401;7017.47368947331;7028.332308430691;7040.471964602675;6915.890653350776;6972.267911869282;6987.707274154298;6995.642091795967;7039.366457018893;6991.23096459389;7016.368861676871;7018.613671351663;7026.859462810715;7051.8364469863955;6684.331566843277;6712.93287067123;6738.59568425896;6820.0903746950935;6830.351116643911;6648.734050638114;6664.83337916556;6668.333166683293;6706.362895524917;6748.527603067738;6925.3074692530345;6929.237783843874;6955.686994085379;6964.129483814523;7001.719931202695;5390.919136213039;5421.186821976577;5428.70142142186;5477.972610136924;5486.396496385474;6640.269570347161;6721.327867213435;6769.120014398097;6804.047433359235;6823.147106611674;6328.019157030668;6459.580127291711;6476.384743449365;6498.610083395011;6502.772402965874;6456.903146452713;6491.05879647439;6493.253275873335;6588.374104460068;6608.570442921195;6251.9687401562705;6398.90401643985;6462.579932304385;6502.414782669583;6519.934800652122;6507.381798729113;6559.540832141704;6568.277489476058;6614.272430032789;6688.83277918056;6350.333215012357;6368.203974503187;6385.8722825544155;6392.4246817786625;6510.73957041713 15:16:15 INFO - PID 3807 | |5;yui.html;963.8457846744523;980.9950950245247;985.3201291109134;993.0516356879181;999.745065008423;19875.900620496894;20060.598788024232;20087.39737807868;20151.49621259469;20165.697514537293;18875.339363122293;18894.527636809085;18940.905295473538;19053.428397148073;19062.809371906278;1026.907578317953;1065.0627447845884;1066.5040756048436;1067.3649178738638;1067.5409573883267;1079.2175672637354;1084.262701363073;1085.1047885494459;1085.3813326403913;1088.3415533602135;1064.2603390643505;1097.8627671541058;1114.164376717462;1114.570890207272;1114.788190243855;1103.8289065194826;1103.8840921703186;1104.2380757277533;1104.6851647280566;1104.9613263535778;795.6817273090752;819.1317203764029;820.1880138662741;820.2535692519838;820.8194197276649;21643.567128657494;21873.12507499698;21877.343679689635;21891.343259702233;21893.781062189333;21563.353099407042;21610.35168944934;22275.220367287227;22301.330960071224;22456.101755929743;17787.644247115113;17854.910725446418;18211.45365639033;18216;18281.908590457097;3977.105151340954;4012.879613611567;4014.6788256939376;4015;4015.859444919443;115937;134568;159827;162872;166436;17609.823901761076;18136.818631813778;18258.634827303646;18265.63468730618;18266;33467.330653386794;33832;34033.829830850686;34063.65936340605;34071.659283407345;9613.471259080818;9778.41329520231;9845.310828242098;9879.506024698736;9931.50342482873;4590.288505281686;4609.032103258353;4677.368555244999;4678.3216433616935;4679.695819771704;5509.834704958857;5530.834074977757;5599.468050535193;5638.577106717013;5638.661680299195;1088.7278180454887;1097.5609756097624;1111.8776934537195;1119.6137332620233;1120.0983208517223;735.3271756342887;746.9290417410338;752.9962350188214;762.1540090499541;775.6199462263451;13595.320233988261;14230.430782768573;14433.927830360992;14739.842624846044;15141.318640661197;754.3851760814919;757.099052127977;760.9961950190213;762.5386641082176;765.1506827421557;6215.564910456224;6276.278228003838;6292.528060395489;6311.873762524724;6420;153950;155154;156405;159036;161783;131486.34256828655;132077.33961330133;132524;133023.33488332498;136195;120758.3962080184;122228;122272;123191;123583;11887.643370698894;12068.758624827278;12069.215500992408;12094.790520947834;12231.449584768885;51309.61113356664;52250.477495224564;52446.95106097933;53181;54021.45978540322;66762.6661866707;68708.65645671739;68922.86497252146;69077.65461172663;69679.30320696728;15765.68468630598;15986.200689965222;16121.113338766012;16130.758038629196;16148.919255403647;18309;18419;18567.90716046411;18638.440846774618;18645.440636780375;12576.434060467484;12606.87393126057;12710.555130570385;12711.61865144047;12801.679958001125;17654.911725441292;18132.909335453238;18167.818321816612;18199.545011374823;18224.72662910084;14752.926235368754;14859.554213373616;14955.476558320406;15001.924990374979;15251.542453726406;11625.476853541442;11717.06263498901;11843.763124737628;11847.585334513251;11973.76052478963;12264.448099835707;12377.62867113988;12435.875641243472;12542.24746515212;12581.861083615624 15:16:15 INFO - PID 3807 | __end_tp_report 15:16:15 INFO - PID 3807 | __start_cc_report 15:16:15 INFO - PID 3807 | _x_x_mozilla_cycle_collect,337 15:16:15 INFO - PID 3807 | __end_cc_report 15:16:15 INFO - PID 3807 | __startTimestamp1504908975881__endTimestamp 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | ------- Summary: start ------- 15:16:15 INFO - PID 3807 | Number of tests: 6 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#0] dojo.html Cycles:165 Average:6188.91 Median:6482.81 stddev:870.72 (13.4%) stddev-sans-first:853.85 15:16:15 INFO - PID 3807 | Values: 3850.5 3852.7 3863.2 3873.8 3893.1 6137.5 6219.7 6244.9 6252.2 6342.6 6148.0 6209.4 6238.5 6362.8 6388.4 5545.7 5642.5 5663.6 5673.4 5677.0 301.3 5280.5 5519.6 5604.6 5621.6 5534.2 5546.6 5608.9 5614.5 5631.1 5536.6 5555.1 5608.9 5611.6 5618.5 5493.2 5568.5 5584.7 5590.5 5665.1 6125.2 6182.4 6220.4 6259.0 6262.7 6619.8 6622.9 6624.5 6704.5 6782.7 6762.3 6794.5 6891.3 6900.3 6920.1 6205.7 6291.2 6315.2 6364.8 6406.5 6952.6 6962.5 6965.1 7022.8 7052.4 6562.0 6667.5 6674.9 6678.4 6684.5 6679.0 6708.8 6714.8 6728.1 6811.4 6605.5 6729.1 6739.5 6746.1 6749.2 6668.5 6689.1 6738.1 6759.2 6779.8 4857.1 4963.0 4972.8 4973.5 4999.5 4456.3 4461.9 4478.4 4488.7 4522.3 6100.7 6148.8 6189.4 6219.7 6292.9 6750.3 6772.6 6794.0 6809.5 6811.8 6125.3 6219.6 6256.9 6277.8 6288.8 5393.6 5464.0 5467.8 5506.4 5532.0 6932.5 7000.9 7008.9 7035.0 7040.7 6740.3 6763.2 6829.2 6855.8 6861.1 6800.5 6838.8 6937.9 6939.4 7025.5 6627.4 6654.3 6665.7 6674.6 6678.9 6855.5 6868.9 6886.9 6896.1 6904.9 6450.6 6552.9 6572.2 6628.7 6645.7 6509.3 6511.2 6613.7 6622.9 6627.6 6473.4 6478.8 6557.8 6558.1 6563.4 6504.7 6570.7 6612.7 6707.5 6709.8 6367.6 6474.4 6477.1 6478.7 6482.8 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#1] ext.html Cycles:180 Average:42342.33 Median:3711.55 stddev:63310.19 (1705.8%) stddev-sans-first:63411.44 15:16:15 INFO - PID 3807 | Values: 933.7 952.2 978.1 979.1 982.6 43430.8 45107.8 45118.3 45128.5 45132.0 41974.4 42457.6 44958.3 45879.5 46046.3 7880.0 7990.5 8006.8 8013.8 8021.9 7820.5 7825.4 7839.7 7870.5 7872.6 7910.6 7915.1 7933.2 7943.0 7946.6 7845.5 7885.0 7889.7 7905.4 7926.8 7955.5 8003.1 8006.4 8018.3 8027.1 41368.2 41703.0 41725.0 41857.4 41859.4 3669.7 3708.6 3714.5 3720.7 3722.8 34021.3 34024.8 34047.7 34162.0 34202.3 5548.3 5555.2 5573.8 5585.0 5607.1 210979.0 214033.0 223006.0 223110.0 241867.0 53353.5 53804.7 53925.2 54108.2 54121.7 56658.4 56722.1 56784.0 56885.7 56962.1 16898.0 17078.5 17084.7 17094.9 17231.0 14088.5 14090.6 14093.9 14110.3 14128.3 13884.3 13982.2 13984.2 14029.9 14133.6 5775.9 5780.7 5785.0 5824.7 5937.3 1092.2 1094.1 1094.1 1107.8 1113.4 25329.2 25398.5 25443.4 25453.4 25498.0 1190.6 1194.0 1198.1 1204.9 1212.9 13191.8 13551.3 13575.3 13627.7 13644.4 275077.0 275109.0 275891.0 276337.0 281503.0 57821.4 57893.0 57895.7 58031.0 58108.7 1474.5 1480.9 1499.1 1513.7 1544.0 24765.3 24810.9 24818.2 24868.4 24876.1 38632.0 40038.2 40154.6 40233.6 40252.4 226749.9 226764.0 226895.0 227729.0 228331.0 34277.3 34839.3 35575.8 36872.3 37245.8 47621.8 47739.3 47977.0 48056.0 48291.5 35380.5 35463.0 35823.3 36018.9 36155.5 35340.8 35468.8 35518.6 35570.3 36146.3 39335.4 40362.6 40627.4 40714.6 41148.6 33992.5 34095.0 34243.0 34439.0 34696.0 25790.5 25831.0 26035.6 26288.1 26299.6 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#2] jquery.html Cycles:180 Average:40514.51 Median:21681.96 stddev:103982.72 (479.6%) stddev-sans-first:104231.21 15:16:15 INFO - PID 3807 | Values: 591.7 601.1 605.8 614.0 620.5 23398.6 23965.2 24149.3 24153.6 24165.2 24559.9 27218.3 27428.3 27460.3 27520.9 6867.3 6891.8 6897.0 6899.0 6926.2 6698.2 6842.3 6912.8 6942.7 6955.8 6895.5 6904.2 6907.1 6912.9 6913.2 6662.7 6889.6 6890.9 6901.3 6907.6 6391.5 6409.2 6420.1 6425.7 6427.9 31320.5 31886.7 31896.7 31899.8 31954.7 2262.3 2294.5 2296.7 2297.1 2299.2 21035.5 21411.4 21508.0 21532.8 21550.2 2269.1 2273.4 2301.5 2301.8 2314.8 140351.0 147553.0 158881.0 164326.2 164522.0 15874.4 16701.6 16707.7 16831.7 16898.4 25953.9 25979.9 25986.0 26028.7 26050.0 10840.9 10881.9 10913.2 10932.0 10982.9 10001.7 10075.8 10100.3 10121.7 10213.6 10029.6 10130.6 10241.1 10349.5 10353.6 2806.8 2837.6 2841.4 2852.5 2909.3 1003.1 1003.4 1015.7 1023.5 1025.8 21311.4 21813.7 21861.2 21913.2 21936.9 1076.1 1078.7 1089.6 1102.2 1104.6 11558.7 11625.9 11724.3 11798.2 11896.0 610856.0 618798.0 621559.0 627438.0 632265.0 122339.0 129007.4 129922.0 131598.0 133011.0 1217.3 1223.2 1238.8 1250.7 1258.7 19103.2 19173.2 19222.8 19312.7 19319.5 61872.0 62520.0 62827.0 63359.0 64303.7 75064.0 78902.0 80621.0 80660.6 80955.6 15437.7 15596.2 15776.8 15792.9 15806.5 24478.8 24499.5 24686.4 24829.6 24835.5 19643.7 20071.3 20090.4 20259.7 20347.4 17023.1 17162.8 17436.0 17932.4 17973.8 20248.8 20407.9 20506.7 20774.2 20803.5 15433.5 15458.6 15506.1 15508.3 15513.4 19744.9 19786.0 20003.6 20045.9 20315.2 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#3] mootools.html Cycles:180 Average:10231.25 Median:2822.92 stddev:7679.21 (272.0%) stddev-sans-first:7671.88 15:16:15 INFO - PID 3807 | Values: 1368.1 1429.7 1441.9 1456.7 1457.1 16551.0 17116.6 17143.7 17177.9 17189.9 16661.4 16814.7 16826.9 16832.5 16852.7 2711.4 2822.8 2823.4 2829.0 2831.3 2741.0 2823.0 2826.8 2829.8 2832.8 2817.8 2904.2 2909.6 2909.9 2910.5 2770.7 2785.6 2794.5 2794.9 2803.1 2822.5 2826.1 2840.8 2841.9 2843.8 16458.8 16570.4 16649.5 16760.7 16763.3 8113.5 8431.9 8458.7 8475.6 8487.2 5366.5 5478.6 5508.6 5521.0 5529.3 2114.0 2132.1 2149.1 2194.1 2205.0 30139.8 30432.7 30453.2 30500.4 30505.4 7016.5 7087.9 7095.1 7174.4 7262.6 19344.0 19423.0 19435.4 19441.2 19450.1 8299.1 8468.1 8477.2 8478.1 8482.2 7558.5 7616.5 7756.3 7769.9 7771.4 5521.7 5656.7 5665.7 5698.4 5707.4 1477.2 1531.4 1607.2 1620.8 1668.5 892.5 905.3 910.4 912.3 919.9 7880.0 7972.1 8011.1 8029.8 8045.4 988.6 990.2 993.8 999.2 1002.8 4705.8 4766.7 4780.4 4810.8 4900.7 24051.9 24116.6 24694.1 24972.4 24982.4 23888.5 24255.2 24556.3 24675.0 24763.8 12434.6 12521.3 12685.7 12689.2 12713.8 8411.7 8509.7 8554.1 8593.3 8625.6 20664.9 21064.1 21134.8 21472.1 21499.0 21206.8 21745.8 22169.8 22253.2 22663.8 11983.2 12136.2 12233.7 12263.6 12296.0 15167.8 15556.1 15559.5 15564.8 15586.1 12047.2 12086.1 12095.0 12197.9 12365.4 12207.8 12219.5 12278.4 12280.5 12545.8 9823.3 9837.0 9874.9 9900.7 9986.6 7810.7 7837.9 7943.3 7946.5 7976.6 7865.0 8009.4 8013.5 8043.8 8168.7 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#4] prototype.html Cycles:180 Average:5679.43 Median:6254.37 stddev:1548.09 (24.8%) stddev-sans-first:1503.12 15:16:15 INFO - PID 3807 | Values: 514.6 528.7 549.8 550.3 573.7 6259.7 6268.5 6351.4 6355.7 6382.4 6256.8 6264.9 6293.4 6303.1 6345.7 5038.0 5048.6 5111.5 5121.8 5141.2 4956.7 4971.8 4991.1 5009.0 5016.2 4934.2 4949.7 4955.0 4972.2 4995.2 4928.2 4949.8 4975.7 4995.3 5025.7 4617.6 4628.9 4640.5 4650.9 4660.0 6087.8 6119.5 6139.7 6186.3 6235.9 5840.4 5851.5 5893.3 5901.1 5940.6 6607.3 6626.7 6671.4 6684.2 6694.4 5058.4 5100.9 5122.2 5128.9 5142.8 6868.7 6878.6 6887.1 6987.2 7020.2 5493.6 5516.8 5537.6 5544.6 5552.9 5605.5 5630.7 5631.2 5635.1 5647.0 5999.5 6068.7 6089.7 6090.6 6114.7 6675.1 6713.7 6724.8 6751.5 6787.0 1928.0 1930.5 1932.6 1936.1 1965.2 1401.9 1449.2 1462.2 1475.5 1495.1 5976.4 6190.7 6202.7 6219.2 6241.1 6545.6 6635.6 6666.5 6732.1 6795.6 6093.8 6106.6 6132.2 6148.7 6185.0 3529.9 3550.0 3571.2 3577.5 3603.9 6994.1 7004.6 7017.5 7028.3 7040.5 6915.9 6972.3 6987.7 6995.6 7039.4 6991.2 7016.4 7018.6 7026.9 7051.8 6684.3 6712.9 6738.6 6820.1 6830.4 6648.7 6664.8 6668.3 6706.4 6748.5 6925.3 6929.2 6955.7 6964.1 7001.7 5390.9 5421.2 5428.7 5478.0 5486.4 6640.3 6721.3 6769.1 6804.0 6823.1 6328.0 6459.6 6476.4 6498.6 6502.8 6456.9 6491.1 6493.3 6588.4 6608.6 6252.0 6398.9 6462.6 6502.4 6519.9 6507.4 6559.5 6568.3 6614.3 6688.8 6350.3 6368.2 6385.9 6392.4 6510.7 15:16:15 INFO - PID 3807 | 15:16:15 INFO - PID 3807 | [#5] yui.html Cycles:180 Average:27917.92 Median:18241.68 stddev:42552.41 (233.3%) stddev-sans-first:42623.65 15:16:15 INFO - PID 3807 | Values: 963.8 981.0 985.3 993.1 999.7 19875.9 20060.6 20087.4 20151.5 20165.7 18875.3 18894.5 18940.9 19053.4 19062.8 1026.9 1065.1 1066.5 1067.4 1067.5 1079.2 1084.3 1085.1 1085.4 1088.3 1064.3 1097.9 1114.2 1114.6 1114.8 1103.8 1103.9 1104.2 1104.7 1105.0 795.7 819.1 820.2 820.3 820.8 21643.6 21873.1 21877.3 21891.3 21893.8 21563.4 21610.4 22275.2 22301.3 22456.1 17787.6 17854.9 18211.5 18216.0 18281.9 3977.1 4012.9 4014.7 4015.0 4015.9 115937.0 134568.0 159827.0 162872.0 166436.0 17609.8 18136.8 18258.6 18265.6 18266.0 33467.3 33832.0 34033.8 34063.7 34071.7 9613.5 9778.4 9845.3 9879.5 9931.5 4590.3 4609.0 4677.4 4678.3 4679.7 5509.8 5530.8 5599.5 5638.6 5638.7 1088.7 1097.6 1111.9 1119.6 1120.1 735.3 746.9 753.0 762.2 775.6 13595.3 14230.4 14433.9 14739.8 15141.3 754.4 757.1 761.0 762.5 765.2 6215.6 6276.3 6292.5 6311.9 6420.0 153950.0 155154.0 156405.0 159036.0 161783.0 131486.3 132077.3 132524.0 133023.3 136195.0 120758.4 122228.0 122272.0 123191.0 123583.0 11887.6 12068.8 12069.2 12094.8 12231.4 51309.6 52250.5 52447.0 53181.0 54021.5 66762.7 68708.7 68922.9 69077.7 69679.3 15765.7 15986.2 16121.1 16130.8 16148.9 18309.0 18419.0 18567.9 18638.4 18645.4 12576.4 12606.9 12710.6 12711.6 12801.7 17654.9 18132.9 18167.8 18199.5 18224.7 14752.9 14859.6 14955.5 15001.9 15251.5 11625.5 11717.1 11843.8 11847.6 11973.8 12264.4 12377.6 12435.9 12542.2 12581.9 15:16:15 INFO - PID 3807 | -------- Summary: end -------- 15:16:15 INFO - PID 3807 | 15:16:16 INFO - TEST-INFO | 3807: exit 0 15:16:16 INFO - TEST-OK | dromaeo_css | took 1110986ms 15:16:16 INFO - TEST-START | kraken 15:16:16 INFO - Initialising browser for kraken test... 15:16:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42435/getInfo.html -profile /tmp/tmp8MiXJr/profile 15:16:16 INFO - TEST-INFO | started process 4188 (/builds/slave/test/build/application/firefox/firefox http://localhost:42435/getInfo.html) 15:16:22 INFO - TEST-INFO | 4188: exit 0 15:16:22 INFO - Browser initialized. 15:16:22 INFO - Running cycle 1/1 for kraken test... 15:16:22 INFO - Using env: {'DISPLAY': ':0', 15:16:22 INFO - 'HOME': '/home/cltbld', 15:16:22 INFO - 'JSGC_DISABLE_POISONING': '1', 15:16:22 INFO - 'LANG': 'en_US.UTF-8', 15:16:22 INFO - 'LANGUAGE': 'en_US:en', 15:16:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:16:22 INFO - 'LOGNAME': 'cltbld', 15:16:22 INFO - 'MAIL': '/var/mail/cltbld', 15:16:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:16:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:16:22 INFO - 'MOZ_CRASHREPORTER': '1', 15:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:16:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:16:22 INFO - 'MOZ_NO_REMOTE': '1', 15:16:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:16:22 INFO - 'NO_EM_RESTART': '1', 15:16:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:16:22 INFO - 'PWD': '/builds/slave/test', 15:16:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:16:22 INFO - 'RUST_BACKTRACE': 'full', 15:16:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:16:22 INFO - 'SHELL': '/bin/bash', 15:16:22 INFO - 'SHLVL': '1', 15:16:22 INFO - 'TERM': 'linux', 15:16:22 INFO - 'TMOUT': '86400', 15:16:22 INFO - 'USER': 'cltbld', 15:16:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822', 15:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:16:22 INFO - '_': '/tools/buildbot/bin/python'} 15:16:22 INFO - TEST-INFO | started process 4389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MiXJr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:23 INFO - PID 4389 | 15:16:23 INFO - PID 4389 | (/builds/slave/test/build/application/firefox/firefox:4440): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:16:23 INFO - PID 4389 | 15:16:33 INFO - PID 4389 | RSS: Main: 164741120 15:16:33 INFO - PID 4389 | 15:16:36 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42435/tests/kraken/driver.html?testName=audio-beat-detection) 15:16:37 INFO - PID 4389 | RSS: Main: 169635840 15:16:37 INFO - PID 4389 | 15:16:39 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42435/tests/kraken/driver.html?testName=audio-dft) 15:16:40 INFO - PID 4389 | RSS: Main: 170041344 15:16:40 INFO - PID 4389 | 15:16:43 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42435/tests/kraken/driver.html?testName=audio-fft) 15:16:43 INFO - PID 4389 | RSS: Main: 164548608 15:16:43 INFO - PID 4389 | 15:16:46 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42435/tests/kraken/driver.html?testName=audio-oscillator) 15:16:46 INFO - PID 4389 | RSS: Main: 165765120 15:16:46 INFO - PID 4389 | 15:16:48 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:16:49 INFO - PID 4389 | RSS: Main: 165675008 15:16:49 INFO - PID 4389 | 15:16:52 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42435/tests/kraken/driver.html?testName=imaging-darkroom) 15:16:52 INFO - PID 4389 | RSS: Main: 169103360 15:16:52 INFO - PID 4389 | 15:16:56 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42435/tests/kraken/driver.html?testName=imaging-desaturate) 15:16:57 INFO - PID 4389 | RSS: Main: 171016192 15:16:57 INFO - PID 4389 | 15:16:59 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42435/tests/kraken/driver.html?testName=json-parse-financial) 15:17:00 INFO - PID 4389 | RSS: Main: 169619456 15:17:00 INFO - PID 4389 | 15:17:01 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:02 INFO - PID 4389 | RSS: Main: 168906752 15:17:02 INFO - PID 4389 | 15:17:04 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:04 INFO - PID 4389 | RSS: Main: 168955904 15:17:04 INFO - PID 4389 | 15:17:06 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:07 INFO - PID 4389 | RSS: Main: 166141952 15:17:07 INFO - PID 4389 | 15:17:09 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:10 INFO - PID 4389 | RSS: Main: 166191104 15:17:10 INFO - PID 4389 | 15:17:13 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:13 INFO - PID 4389 | RSS: Main: 166854656 15:17:13 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | Cycle 1(1): loaded http://localhost:42435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42435/tests/kraken/driver.html?testName=ai-astar) 15:17:15 INFO - PID 4389 | RSS: Main: 168542208 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | __start_tp_report 15:17:15 INFO - PID 4389 | _x_x_mozilla_page_load 15:17:15 INFO - PID 4389 | _x_x_mozilla_page_load_details 15:17:15 INFO - PID 4389 | |i|pagename|runs| 15:17:15 INFO - PID 4389 | |0;ai-astar;107;107;105;106;105;109;108;106;107;107 15:17:15 INFO - PID 4389 | |1;audio-beat-detection;112;113;113;111;113;122;136;112;114;111 15:17:15 INFO - PID 4389 | |2;audio-dft;162;162;165;161;161;164;163;162;167;165 15:17:15 INFO - PID 4389 | |3;audio-fft;73;73;73;75;72;74;73;74;74;73 15:17:15 INFO - PID 4389 | |4;audio-oscillator;78;78;77;79;77;78;78;79;77;78 15:17:15 INFO - PID 4389 | |5;imaging-gaussian-blur;113;115;114;113;113;114;113;114;114;116 15:17:15 INFO - PID 4389 | |6;imaging-darkroom;150;151;150;156;149;148;149;152;149;151 15:17:15 INFO - PID 4389 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;94;94 15:17:15 INFO - PID 4389 | |8;json-parse-financial;43;44;44;44;46;47;45;44;43;43 15:17:15 INFO - PID 4389 | |9;json-stringify-tinderbox;36;36;37;37;36;37;38;37;37;37 15:17:15 INFO - PID 4389 | |10;stanford-crypto-aes;72;73;69;72;72;72;73;72;72;72 15:17:15 INFO - PID 4389 | |11;stanford-crypto-ccm;117;109;108;116;109;121;110;117;113;108 15:17:15 INFO - PID 4389 | |12;stanford-crypto-pbkdf2;160;156;156;151;153;153;155;152;153;155 15:17:15 INFO - PID 4389 | |13;stanford-crypto-sha256-iterative;62;58;56;58;60;57;57;58;60;60 15:17:15 INFO - PID 4389 | __end_tp_report 15:17:15 INFO - PID 4389 | __start_cc_report 15:17:15 INFO - PID 4389 | _x_x_mozilla_cycle_collect,920 15:17:15 INFO - PID 4389 | __end_cc_report 15:17:15 INFO - PID 4389 | __startTimestamp1504909035838__endTimestamp 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | ------- Summary: start ------- 15:17:15 INFO - PID 4389 | Number of tests: 14 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#0] ai-astar Cycles:10 Average:106.70 Median:107.00 stddev:1.25 (1.2%) stddev-sans-first:1.32 15:17:15 INFO - PID 4389 | Values: 107.0 107.0 105.0 106.0 105.0 109.0 108.0 106.0 107.0 107.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.00 stddev:7.80 (6.9%) stddev-sans-first:8.16 15:17:15 INFO - PID 4389 | Values: 112.0 113.0 113.0 111.0 113.0 122.0 136.0 112.0 114.0 111.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.99 (1.2%) stddev-sans-first:2.06 15:17:15 INFO - PID 4389 | Values: 162.0 162.0 165.0 161.0 161.0 164.0 163.0 162.0 167.0 165.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 15:17:15 INFO - PID 4389 | Values: 73.0 73.0 73.0 75.0 72.0 74.0 73.0 74.0 74.0 73.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 15:17:15 INFO - PID 4389 | Values: 78.0 78.0 77.0 79.0 77.0 78.0 78.0 79.0 77.0 78.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 15:17:15 INFO - PID 4389 | Values: 113.0 115.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 116.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:2.27 (1.5%) stddev-sans-first:2.40 15:17:15 INFO - PID 4389 | Values: 150.0 151.0 150.0 156.0 149.0 148.0 149.0 152.0 149.0 151.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 15:17:15 INFO - PID 4389 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#8] json-parse-financial Cycles:10 Average:44.30 Median:44.00 stddev:1.34 (3.0%) stddev-sans-first:1.33 15:17:15 INFO - PID 4389 | Values: 43.0 44.0 44.0 44.0 46.0 47.0 45.0 44.0 43.0 43.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.60 15:17:15 INFO - PID 4389 | Values: 36.0 36.0 37.0 37.0 36.0 37.0 38.0 37.0 37.0 37.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:72.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 15:17:15 INFO - PID 4389 | Values: 72.0 73.0 69.0 72.0 72.0 72.0 73.0 72.0 72.0 72.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:114.50 stddev:4.66 (4.1%) stddev-sans-first:4.69 15:17:15 INFO - PID 4389 | Values: 117.0 109.0 108.0 116.0 109.0 121.0 110.0 117.0 113.0 108.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:2.59 (1.7%) stddev-sans-first:1.79 15:17:15 INFO - PID 4389 | Values: 160.0 156.0 156.0 151.0 153.0 153.0 155.0 152.0 153.0 155.0 15:17:15 INFO - PID 4389 | 15:17:15 INFO - PID 4389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:59.00 stddev:1.84 (3.1%) stddev-sans-first:1.48 15:17:15 INFO - PID 4389 | Values: 62.0 58.0 56.0 58.0 60.0 57.0 57.0 58.0 60.0 60.0 15:17:15 INFO - PID 4389 | -------- Summary: end -------- 15:17:15 INFO - PID 4389 | 15:17:16 INFO - PID 4389 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:17:16 INFO - TEST-INFO | 4389: exit 0 15:17:16 INFO - TEST-OK | kraken | took 59913ms 15:17:16 INFO - SUITE-END | took 1170s 15:17:17 INFO - Completed test suite (00:19:31) 15:17:17 INFO - javascript benchmark 15:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9005.909590971994, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3850.460935469033, 3852.672522835559, 3863.227354529095, 3873.8256778444975, 3893.0851249956254, 6137.539684523656, 6219.657918814463, 6244.937550624492, 6252.155958945541, 6342.556021078526, 6148.047052706837, 6209.410106039931, 6238.500919926406, 6362.809115726535, 6388.361163883609, 5545.694986775726, 5642.520385767215, 5663.631863928852, 5673.404292549285, 5676.971615141919, 301.31640080532753, 5280.498352656491, 5519.586031047667, 5604.579656525756, 5621.634593751393, 5534.197541356501, 5546.55627549795, 5608.915866262009, 5614.494695477386, 5631.099024156136, 5536.557075433956, 5555.111182210867, 5608.915866262009, 5611.551075913917, 5618.494335509824, 5493.176023596453, 5568.49883510482, 5584.692841893694, 5590.524805391547, 5665.065264231397, 6125.234345706786, 6182.412670796312, 6220.440160385587, 6259.0, 6262.749490020394, 6619.801405957829, 6622.9006564901565, 6624.53628246023, 6704.497162712767, 6782.694778734969, 6762.289959554274, 6794.490413219029, 6891.345322194434, 6900.3099690031095, 6920.065791118185, 6205.658688772116, 6291.213598300213, 6315.24217093947, 6364.77723279683, 6406.455451286646, 6952.582845029315, 6962.512624116364, 6965.094537710065, 7022.754203602952, 7052.365287124081, 6562.0, 6667.466602671775, 6674.866502669919, 6678.3989440950545, 6684.532082754258, 6679.031540426611, 6708.765193218214, 6714.832129196711, 6728.125343705287, 6811.4210292124735, 6605.471562275103, 6729.0915726376315, 6739.460843132538, 6746.089277947414, 6749.190097188369, 6668.533202675766, 6689.063531105649, 6738.056672065914, 6759.188897332351, 6779.796606101825, 4857.125717370907, 4962.950370496249, 4972.825951091694, 4973.452920178777, 4999.525045120708, 4456.286994080931, 4461.910761784746, 4478.373027776114, 4488.730676159441, 4522.253828118323, 6100.664463454553, 6148.815535533941, 6189.35011823752, 6219.689015549295, 6292.905606415908, 6750.3249675033085, 6772.627505487246, 6794.0, 6809.489288303397, 6811.829704257334, 6125.326214116443, 6219.595726277868, 6256.937430625727, 6277.843053923689, 6288.811335659938, 5393.568514518829, 5464.043792336325, 5467.781288748485, 5506.366767821672, 5531.9723401382735, 6932.514723969273, 7000.859982800315, 7008.894866577006, 7034.964825175842, 7040.718371265194, 6740.325967403221, 6763.222229443677, 6829.248782633907, 6855.7600483983815, 6861.142357205349, 6800.455963523005, 6838.794836154923, 6937.930620693728, 6939.4448444125355, 7025.508214424941, 6627.37039981201, 6654.334566543307, 6665.700043497957, 6674.566153200027, 6678.899816502659, 6855.451563874978, 6868.862622747617, 6886.931130688629, 6896.137982752156, 6904.930950690429, 6450.645214513247, 6552.901706474502, 6572.244191917991, 6628.668566571556, 6645.6677166140535, 6509.349065093642, 6511.218653761579, 6613.735450581923, 6622.933770662425, 6627.602343859384, 6473.352664733489, 6478.805635830932, 6557.803265902031, 6558.147440832661, 6563.409293163638, 6504.674766261763, 6570.704318305783, 6612.669366531558, 6707.463402927657, 6709.7651582194385, 6367.554271200971, 6474.449671777763, 6477.093206950936, 6478.740850366121, 6482.805515834532], "value": 6131.103356090097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.7012156110047, 952.1620973543282, 978.124578502241, 979.1236843025492, 982.5578489679641, 43430.78284608576, 45107.77446112769, 45118.323225151566, 45128.54871451284, 45132.0, 41974.37038444426, 42457.57542424575, 44958.32562511565, 45879.54120458794, 46046.309305360446, 7880.014998125234, 7990.4806187597915, 8006.759797206093, 8013.799655008613, 8021.879671804928, 7820.45256832022, 7825.37397008238, 7839.686412543491, 7870.527768333918, 7872.645730942093, 7910.644021019068, 7915.12933577306, 7933.246341597568, 7942.9602851985655, 7946.562939038351, 7845.490043147234, 7885.0, 7889.723859664884, 7905.367570594367, 7926.801829954268, 7955.4828936118965, 8003.079645840745, 8006.3995200360205, 8018.278354948083, 8027.076886158108, 41368.172636547104, 41703.0, 41725.0, 41857.37213941793, 41859.372109418386, 3669.6697297243377, 3708.647678470541, 3714.461403096563, 3720.720945929066, 3722.758020728671, 34021.319573608635, 34024.82987585046, 34047.659523404946, 34162.0, 34202.315953681034, 5548.334199895998, 5555.194496797942, 5573.804916827891, 5584.972075139639, 5607.102863541813, 210979.0, 214033.0, 223006.0, 223110.0, 241867.0, 53353.46646533562, 53804.730976344865, 53925.1911221332, 54108.188377174374, 54121.72939135279, 56658.43341566614, 56722.149167762516, 56784.0, 56885.715571422705, 56962.145567816515, 16898.0, 17078.48764537066, 17084.658306833793, 17094.91452542729, 17231.0, 14088.506902258578, 14090.647733806736, 14093.859061409255, 14110.294485275695, 14128.293585320693, 13884.305784710725, 13982.161070335813, 13984.160950343012, 14029.859701402855, 14133.575992720234, 5775.913361299584, 5780.710964451845, 5784.971075144597, 5824.737886795105, 5937.317208520989, 1092.208149091918, 1094.0973696700255, 1094.1137678480457, 1107.8061339265596, 1113.437713954464, 25329.240122796346, 25398.492030159294, 25443.36391590188, 25453.3636659085, 25498.0, 1190.571394298052, 1193.9731830625656, 1198.0714945916984, 1204.9096317776202, 1212.921160124589, 13191.80212296797, 13551.254680992442, 13575.253361065235, 13627.727445451035, 13644.386002629706, 275077.0, 275109.0, 275891.0, 276337.0, 281503.0, 57821.421785781604, 57893.0, 57895.71052144712, 58031.0, 58108.709456453296, 1474.4544518527998, 1480.851914808532, 1499.137995652504, 1513.674559969612, 1544.0, 24765.26114541605, 24810.875945620155, 24818.246187906756, 24868.37829054288, 24876.12933547317, 38632.0, 40038.19923601453, 40154.59845401509, 40233.59766402416, 40252.39621405623, 226749.8662506677, 226764.0, 226895.0, 227729.0, 228331.0, 34277.31445371128, 34839.30321393609, 35575.82212088923, 36872.26255474929, 37245.813770930974, 47621.76189119032, 47739.28391074067, 47977.0, 48056.0, 48291.517084830106, 35380.46929296114, 35463.0, 35823.28353432865, 36018.91943241707, 36155.457668135525, 35340.823295883354, 35468.82265588656, 35518.64481355153, 35570.288594228485, 36146.27707445889, 39335.40996885106, 40362.59637403706, 40627.390589141774, 40714.59285407227, 41148.588514114475, 33992.490112648826, 34095.0, 34243.0, 34439.0, 34696.0, 25790.484190315714, 25831.0, 26035.609465858408, 26288.079917202806, 26299.60550591781], "value": 18551.473026595788, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7455494137522, 601.0839381429985, 605.839816750922, 613.9907901381478, 620.4601996263251, 23398.64902026471, 23965.161219357327, 24149.275521734377, 24153.63769543454, 24165.15421960232, 24559.877200614017, 27218.31954201146, 27428.314292142655, 27460.313492162706, 27520.862395687993, 6867.347601977829, 6891.793246202622, 6896.965515172442, 6899.034135221048, 6926.238113807477, 6698.196216454008, 6842.281560436132, 6912.758053468129, 6942.652867356637, 6955.791326260221, 6895.5173137880365, 6904.1714994200765, 6907.0675458813175, 6912.896306555405, 6913.204981427125, 6662.666866656697, 6889.586624802528, 6890.862182756367, 6901.344372284625, 6907.585544867299, 6391.45672617828, 6409.166808314936, 6420.101185833987, 6425.742970281183, 6427.87144257117, 31320.53019204714, 31886.681133188602, 31896.681033189834, 31899.840500797578, 31954.680453195404, 2262.2534563593977, 2294.4608017115966, 2296.6784650148993, 2297.1385730351117, 2299.218265789623, 21035.474113147142, 21411.35765927025, 21508.0, 21532.784672153233, 21550.245741398976, 2269.137727663494, 2273.4430064634107, 2301.493671392291, 2301.79283864453, 2314.7916687498036, 140351.0, 147553.0, 158881.0, 164326.17836910978, 164522.0, 15874.444394446138, 16701.58246043834, 16707.66584668324, 16831.74752378715, 16898.40855570074, 25953.870230648725, 25979.870100649754, 25986.0, 26028.73971260263, 26050.0, 10840.945795270973, 10881.891181088246, 10913.181511386678, 10932.0, 10982.890171098186, 10001.699949001542, 10075.848862267072, 10100.343477673927, 10121.746956326151, 10213.591456341812, 10029.598816047277, 10130.645427410005, 10241.129503992095, 10349.534270957674, 10353.63762268317, 2806.8035237533586, 2837.6311079559937, 2841.4317136572768, 2852.5293326601295, 2909.3163106669917, 1003.1322905686528, 1003.4029752297372, 1015.6943737715345, 1023.518946095334, 1025.7538190834296, 21311.36065918025, 21813.67279490809, 21861.234856780255, 21913.233036843634, 21936.89031554864, 1076.1229597877705, 1078.665613659768, 1089.5641743302583, 1102.2394547762178, 1104.6244276945715, 11558.711032224093, 11625.941870290764, 11724.296542207494, 11798.233114847508, 11896.0, 610856.0, 618798.0, 621559.0, 627438.0, 632265.0, 122339.0, 129007.35496322458, 129922.0, 131598.0, 133011.0, 1217.287886586357, 1223.2049168040667, 1238.789405801016, 1250.7123361626877, 1258.6979125009932, 19103.235870565022, 19173.233070677576, 19222.8077719221, 19312.710309345654, 19319.517012074248, 61872.0, 62520.0, 62827.0, 63359.0, 64303.67848160729, 75064.0, 78902.0, 80621.0, 80660.59669701614, 80955.59522202352, 15437.691246175238, 15596.220188990732, 15776.842231577537, 15792.92103539475, 15806.525804225892, 24478.817753691907, 24499.510009800062, 24686.382840429134, 24829.627555586318, 24835.50328993374, 19643.70534441956, 20071.29750458727, 20090.397288080796, 20259.69610455815, 20347.389578312675, 17023.148842558072, 17162.828371716623, 17436.0, 17932.372366967094, 17973.820261797213, 20248.797512024692, 20407.8979605101, 20506.692399614316, 20774.1690332385, 20803.47991300169, 15433.5369938902, 15458.613534661274, 15506.147161906203, 15508.302126404113, 15513.379464821732, 19744.853580748204, 19786.0, 20003.59992800165, 20045.899770501055, 20315.187392504133], "value": 12918.216350837487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.1038919507723, 1429.7212043651487, 1441.8990670653052, 1456.6504039030635, 1457.1475686723259, 16551.0, 17116.572085697862, 17143.657126857455, 17177.914110429447, 17189.914050429732, 16661.416850410238, 16814.747778783327, 16826.915865420688, 16832.495025149234, 16852.747208791847, 2711.4441539484405, 2822.8165169264034, 2823.378856651533, 2829.038127036807, 2831.348789778352, 2740.9588856167175, 2823.026056010683, 2826.802123851331, 2829.7877659175642, 2832.773378129755, 2817.8450185239803, 2904.2013446302226, 2909.563565465176, 2909.8545072746383, 2910.4761142994253, 2770.6536682914734, 2785.5960885671566, 2794.5389010813396, 2794.930126746827, 2803.1310293808983, 2822.520171570838, 2826.053272153831, 2840.8437535935514, 2841.8863245470156, 2843.8293702377923, 16458.83541164585, 16570.420035298826, 16649.500514984447, 16760.748588771177, 16763.329466821313, 8113.472624279403, 8431.915680843174, 8458.74623761288, 8475.618597163142, 8487.193716596976, 5366.4633536646415, 5478.58910581704, 5508.614396992212, 5521.033819081645, 5529.281193444866, 2114.0, 2132.125828410344, 2149.108120130144, 2194.089452877054, 2204.9779502204933, 30139.849300753576, 30432.695673043207, 30453.23866903345, 30500.389992200253, 30505.38989220203, 7016.473764467685, 7087.92912070883, 7095.077639906883, 7174.390176834923, 7262.564246145248, 19344.0, 19423.0, 19435.416937491897, 19441.222351105796, 19450.124744386252, 8299.087100418948, 8468.068512463624, 8477.194666506672, 8478.067412584734, 8482.151784821592, 7558.470907036454, 7616.504927179715, 7756.340711039625, 7769.883451748228, 7771.378289736807, 5521.668699878021, 5656.6888821115235, 5665.745041473144, 5698.401667824902, 5707.3721890592005, 1477.1506383829342, 1531.4257153567412, 1607.172306262276, 1620.8136064352514, 1668.5161303222174, 892.5314210039782, 905.3255324782947, 910.4491782471641, 912.2792993535033, 919.852823548229, 7880.0, 7972.123066462685, 8011.078725946474, 8029.8394032120195, 8045.436819422701, 988.6342053440274, 990.1633120013577, 993.7863359377624, 999.160705007797, 1002.8395456727035, 4705.8352957647, 4766.6901651392545, 4780.402449693788, 4810.831620893252, 4900.6814557054395, 24051.879740601184, 24116.63825042626, 24694.13570525023, 24972.37569060788, 24982.375440613767, 23888.52222955531, 24255.151069712476, 24556.263312100666, 24675.0, 24763.752362476505, 12434.62696119118, 12521.311327877054, 12685.746285074432, 12689.175203611736, 12713.809292860615, 8411.747647570583, 8509.74470765878, 8554.144585541644, 8593.31253499731, 8625.568721564023, 20664.896675516527, 21064.05211765505, 21134.788652113897, 21472.141114355876, 21499.0, 21206.787932121097, 21745.782542174376, 22169.77830221677, 22253.221137260767, 22663.773362266165, 11983.221090629082, 12136.211146275464, 12233.69415764613, 12263.570775023189, 12296.0, 15167.848321516643, 15556.144412057445, 15559.533214003599, 15564.766528502309, 15586.06483610987, 12047.216930899463, 12086.093542984136, 12095.0, 12197.878021220029, 12365.381730913597, 12207.755844882875, 12219.45012474423, 12278.386080695751, 12280.508779648713, 12545.811812822632, 9823.263255256028, 9837.0, 9874.851877221703, 9900.702978910644, 9986.60053597848, 7810.687572497037, 7837.882431763414, 7943.285104340406, 7946.523208607502, 7976.6410511525955, 7864.960675196817, 8009.359251260002, 8013.519188848688, 8043.758687239392, 8168.673253070048], "value": 7143.14317679069, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.6397521734787, 528.6748649580508, 549.8377978496343, 550.2736387967884, 573.744683615791, 6259.749610015594, 6268.4671802896755, 6351.396617321353, 6355.71399287032, 6382.361763823616, 6256.781012664557, 6264.937350626492, 6293.395184228027, 6303.077561343788, 6345.716641267138, 5038.0, 5048.570871475929, 5111.539961403473, 5121.820736274231, 5141.228815677641, 4956.7025978441225, 4971.751412429382, 4991.126552853254, 5009.0, 5016.197408414654, 4934.185859333224, 4949.727764972925, 4955.0, 4972.229304457796, 4995.150824359867, 4928.236123400879, 4949.8020079196785, 4975.651704380694, 4995.275685025687, 5025.698458092526, 4617.561331673485, 4628.940121645869, 4640.5127461616385, 4650.930236046428, 4659.953400465985, 6087.847803804896, 6119.5104391648565, 6139.732885644479, 6186.257649082094, 6235.906461403082, 5840.445157710011, 5851.531877449794, 5893.322267939199, 5901.144334071536, 5940.6435613863305, 6607.30623284553, 6626.668666566652, 6671.432928201109, 6684.16447944007, 6694.422647280783, 5058.367704036996, 5100.948990510122, 5122.154844450662, 5128.897287083295, 5142.840007196986, 6868.7252509899545, 6878.55289406187, 6887.140472072562, 6987.196472405637, 7020.192677842062, 5493.599132221258, 5516.841463292753, 5537.640053396516, 5544.556435485232, 5552.944470555323, 5605.467480589337, 5630.74661640219, 5631.211630371751, 5635.098384258499, 5647.0, 5999.480218308321, 6068.726907289182, 6089.725962331617, 6090.604110732788, 6114.724837382329, 6675.0988616537115, 6713.6643167842385, 6724.848048624491, 6751.493637977073, 6787.0, 1928.0359820089955, 1930.5366711989022, 1932.5651728361006, 1936.1093896807627, 1965.1648049579157, 1401.8878489720798, 1449.1667291307328, 1462.1665650579068, 1475.5057055886398, 1495.1029382370707, 5976.432238937294, 6190.721417536221, 6202.689865506707, 6219.191505104308, 6241.126242326078, 6545.607263564201, 6635.6350400728425, 6666.500012499082, 6732.057511948331, 6795.626240556718, 6093.847653808691, 6106.6336019838955, 6132.233470816148, 6148.661823599656, 6184.969075154595, 3529.8588056477965, 3549.982250088785, 3571.160777217352, 3577.5349204603754, 3603.8558457661925, 6994.055802466602, 7004.579725216401, 7017.47368947331, 7028.332308430691, 7040.471964602675, 6915.890653350776, 6972.267911869282, 6987.707274154298, 6995.642091795967, 7039.366457018893, 6991.23096459389, 7016.368861676871, 7018.613671351663, 7026.859462810715, 7051.8364469863955, 6684.331566843277, 6712.93287067123, 6738.59568425896, 6820.0903746950935, 6830.351116643911, 6648.734050638114, 6664.83337916556, 6668.333166683293, 6706.362895524917, 6748.527603067738, 6925.3074692530345, 6929.237783843874, 6955.686994085379, 6964.129483814523, 7001.719931202695, 5390.919136213039, 5421.186821976577, 5428.70142142186, 5477.972610136924, 5486.396496385474, 6640.269570347161, 6721.327867213435, 6769.120014398097, 6804.047433359235, 6823.147106611674, 6328.019157030668, 6459.580127291711, 6476.384743449365, 6498.610083395011, 6502.772402965874, 6456.903146452713, 6491.05879647439, 6493.253275873335, 6588.374104460068, 6608.570442921195, 6251.9687401562705, 6398.90401643985, 6462.579932304385, 6502.414782669583, 6519.934800652122, 6507.381798729113, 6559.540832141704, 6568.277489476058, 6614.272430032789, 6688.83277918056, 6350.333215012357, 6368.203974503187, 6385.8722825544155, 6392.4246817786625, 6510.73957041713], "value": 5240.397101328777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [963.8457846744523, 980.9950950245247, 985.3201291109134, 993.0516356879181, 999.745065008423, 19875.900620496894, 20060.598788024232, 20087.39737807868, 20151.49621259469, 20165.697514537293, 18875.339363122293, 18894.527636809085, 18940.905295473538, 19053.428397148073, 19062.809371906278, 1026.907578317953, 1065.0627447845884, 1066.5040756048436, 1067.3649178738638, 1067.5409573883267, 1079.2175672637354, 1084.262701363073, 1085.1047885494459, 1085.3813326403913, 1088.3415533602135, 1064.2603390643505, 1097.8627671541058, 1114.164376717462, 1114.570890207272, 1114.788190243855, 1103.8289065194826, 1103.8840921703186, 1104.2380757277533, 1104.6851647280566, 1104.9613263535778, 795.6817273090752, 819.1317203764029, 820.1880138662741, 820.2535692519838, 820.8194197276649, 21643.567128657494, 21873.12507499698, 21877.343679689635, 21891.343259702233, 21893.781062189333, 21563.353099407042, 21610.35168944934, 22275.220367287227, 22301.330960071224, 22456.101755929743, 17787.644247115113, 17854.910725446418, 18211.45365639033, 18216.0, 18281.908590457097, 3977.105151340954, 4012.879613611567, 4014.6788256939376, 4015.0, 4015.859444919443, 115937.0, 134568.0, 159827.0, 162872.0, 166436.0, 17609.823901761076, 18136.818631813778, 18258.634827303646, 18265.63468730618, 18266.0, 33467.330653386794, 33832.0, 34033.829830850686, 34063.65936340605, 34071.659283407345, 9613.471259080818, 9778.41329520231, 9845.310828242098, 9879.506024698736, 9931.50342482873, 4590.288505281686, 4609.032103258353, 4677.368555244999, 4678.3216433616935, 4679.695819771704, 5509.834704958857, 5530.834074977757, 5599.468050535193, 5638.577106717013, 5638.661680299195, 1088.7278180454887, 1097.5609756097624, 1111.8776934537195, 1119.6137332620233, 1120.0983208517223, 735.3271756342887, 746.9290417410338, 752.9962350188214, 762.1540090499541, 775.6199462263451, 13595.320233988261, 14230.430782768573, 14433.927830360992, 14739.842624846044, 15141.318640661197, 754.3851760814919, 757.099052127977, 760.9961950190213, 762.5386641082176, 765.1506827421557, 6215.564910456224, 6276.278228003838, 6292.528060395489, 6311.873762524724, 6420.0, 153950.0, 155154.0, 156405.0, 159036.0, 161783.0, 131486.34256828655, 132077.33961330133, 132524.0, 133023.33488332498, 136195.0, 120758.3962080184, 122228.0, 122272.0, 123191.0, 123583.0, 11887.643370698894, 12068.758624827278, 12069.215500992408, 12094.790520947834, 12231.449584768885, 51309.61113356664, 52250.477495224564, 52446.95106097933, 53181.0, 54021.45978540322, 66762.6661866707, 68708.65645671739, 68922.86497252146, 69077.65461172663, 69679.30320696728, 15765.68468630598, 15986.200689965222, 16121.113338766012, 16130.758038629196, 16148.919255403647, 18309.0, 18419.0, 18567.90716046411, 18638.440846774618, 18645.440636780375, 12576.434060467484, 12606.87393126057, 12710.555130570385, 12711.61865144047, 12801.679958001125, 17654.911725441292, 18132.909335453238, 18167.818321816612, 18199.545011374823, 18224.72662910084, 14752.926235368754, 14859.554213373616, 14955.476558320406, 15001.924990374979, 15251.542453726406, 11625.476853541442, 11717.06263498901, 11843.763124737628, 11847.585334513251, 11973.76052478963, 12264.448099835707, 12377.62867113988, 12435.875641243472, 12542.24746515212, 12581.861083615624], "value": 9699.858288759206, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 106.0, 105.0, 109.0, 108.0, 106.0, 107.0, 107.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 111.0, 113.0, 122.0, 136.0, 112.0, 114.0, 111.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 165.0, 161.0, 161.0, 164.0, 163.0, 162.0, 167.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 75.0, 72.0, 74.0, 73.0, 74.0, 74.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 79.0, 77.0, 78.0, 78.0, 79.0, 77.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 156.0, 149.0, 148.0, 149.0, 152.0, 149.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 44.0, 44.0, 46.0, 47.0, 45.0, 44.0, 43.0, 43.0], "value": 44.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 37.0, 37.0, 36.0, 37.0, 38.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 69.0, 72.0, 72.0, 72.0, 73.0, 72.0, 72.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 108.0, 116.0, 109.0, 121.0, 110.0, 117.0, 113.0, 108.0], "value": 112.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 156.0, 151.0, 153.0, 153.0, 155.0, 152.0, 153.0, 155.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 56.0, 58.0, 60.0, 57.0, 57.0, 58.0, 60.0, 60.0], "value": 58.6, "unit": "score"}]}]} 15:17:17 INFO - Return code: 0 15:17:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:17:17 INFO - # TBPL SUCCESS # 15:17:17 INFO - Running post-action listener: _package_coverage_data 15:17:17 INFO - Running post-action listener: _resource_record_post_action 15:17:17 INFO - [mozharness: 2017-09-08 22:17:17.157787Z] Finished run-tests step (success) 15:17:17 INFO - Running post-run listener: _resource_record_post_run 15:17:17 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 6680576; Write bytes: 482996224; Read time: 5828; Write time: 488808 15:17:17 INFO - TinderboxPrint: CPU usage
13.1% 15:17:17 INFO - TinderboxPrint: I/O read bytes / time
6,680,576 / 5,828 15:17:17 INFO - TinderboxPrint: I/O write bytes / time
482,996,224 / 488,808 15:17:17 INFO - TinderboxPrint: CPU idle
8,230.4 (86.9%) 15:17:17 INFO - TinderboxPrint: CPU user
1,184.0 (12.5%) 15:17:17 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 75972608; Read time: 0; Write time: 83904 15:17:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:17:17 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4648960; Write bytes: 407023616; Read time: 5712; Write time: 404904 15:17:17 INFO - Running post-run listener: _upload_blobber_files 15:17:17 INFO - Blob upload gear active. 15:17:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:17:18 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:19 INFO - (blobuploader) - INFO - Done attempting. 15:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:20 INFO - (blobuploader) - INFO - Done attempting. 15:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:23 INFO - (blobuploader) - INFO - Done attempting. 15:17:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:17:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:24 INFO - (blobuploader) - INFO - Done attempting. 15:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 15:17:24 INFO - Return code: 0 15:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:17:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b796846341fe9bb0b99669e5b1bdb43fa519a0ea347ccbdbbaa8c8adac8fcd7b2575fb6dace6b02077a68c1de81d7cee4bc020dda24e085c4037f89041513dd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a56727479965f8f466584b55a2b038382e062a763247554fd739f60421dd174c8790959001d04ec496d39cadfe2e398cddcb2f771374abbef0855f91ebdda0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3ed418b59a959b6ae30dc94c245c6e18dc861acb64dc89333174a5e79e54e521222a2f0dac22d4ac2a7a52d78ea4ab49dfc5c000db0228c2e19d8118e1e4fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72a0a6b3366e4654e7f10ed026293dc0eb42d412d1efcd5a1f7549ea9a2e8f9950b0b208259a37fdb7786f096e061079b91941269a30fad60311fe8a9d0d3014"} 15:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:17:24 INFO - Contents: 15:17:24 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b796846341fe9bb0b99669e5b1bdb43fa519a0ea347ccbdbbaa8c8adac8fcd7b2575fb6dace6b02077a68c1de81d7cee4bc020dda24e085c4037f89041513dd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a56727479965f8f466584b55a2b038382e062a763247554fd739f60421dd174c8790959001d04ec496d39cadfe2e398cddcb2f771374abbef0855f91ebdda0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3ed418b59a959b6ae30dc94c245c6e18dc861acb64dc89333174a5e79e54e521222a2f0dac22d4ac2a7a52d78ea4ab49dfc5c000db0228c2e19d8118e1e4fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72a0a6b3366e4654e7f10ed026293dc0eb42d412d1efcd5a1f7549ea9a2e8f9950b0b208259a37fdb7786f096e061079b91941269a30fad60311fe8a9d0d3014"} 15:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:17:24 INFO - Copying logs to upload dir... 15:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 15:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.499941 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-08 15:17:24.838315) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 15:17:24.841577) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 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/8b796846341fe9bb0b99669e5b1bdb43fa519a0ea347ccbdbbaa8c8adac8fcd7b2575fb6dace6b02077a68c1de81d7cee4bc020dda24e085c4037f89041513dd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a56727479965f8f466584b55a2b038382e062a763247554fd739f60421dd174c8790959001d04ec496d39cadfe2e398cddcb2f771374abbef0855f91ebdda0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3ed418b59a959b6ae30dc94c245c6e18dc861acb64dc89333174a5e79e54e521222a2f0dac22d4ac2a7a52d78ea4ab49dfc5c000db0228c2e19d8118e1e4fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72a0a6b3366e4654e7f10ed026293dc0eb42d412d1efcd5a1f7549ea9a2e8f9950b0b208259a37fdb7786f096e061079b91941269a30fad60311fe8a9d0d3014"} build_url:https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/IMdszc27RVGOKwUOJDrcRA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b796846341fe9bb0b99669e5b1bdb43fa519a0ea347ccbdbbaa8c8adac8fcd7b2575fb6dace6b02077a68c1de81d7cee4bc020dda24e085c4037f89041513dd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a56727479965f8f466584b55a2b038382e062a763247554fd739f60421dd174c8790959001d04ec496d39cadfe2e398cddcb2f771374abbef0855f91ebdda0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3ed418b59a959b6ae30dc94c245c6e18dc861acb64dc89333174a5e79e54e521222a2f0dac22d4ac2a7a52d78ea4ab49dfc5c000db0228c2e19d8118e1e4fa", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72a0a6b3366e4654e7f10ed026293dc0eb42d412d1efcd5a1f7549ea9a2e8f9950b0b208259a37fdb7786f096e061079b91941269a30fad60311fe8a9d0d3014"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 15:17:24.869875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 15:17:24.870231) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1504907803.777999-1563135822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 15:17:24.952225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 15:17:24.952535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 15:17:24.952858) ========= ========= Total master_lag: 0.19 =========