builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1505557104.1 results: success (0) revision: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.103598) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.106049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.106332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.151596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.151864) ========= 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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 03:18:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.7M=0s 2017-09-16 03:18:24 (86.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166534 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.429138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.429474) ========= 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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015954 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.543036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:24.543333) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 --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 c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 --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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 03:18:24,550 truncating revision to first 12 chars 2017-09-16 03:18:24,550 Setting DEBUG logging. 2017-09-16 03:18:24,550 attempt 1/10 2017-09-16 03:18:24,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c99a1520c7a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 03:18:24,825 unpacking tar archive at: mozilla-central-c99a1520c7a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549290 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:25.127122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:25.127455) ========= script_repo_revision: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:25.127805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:25.128080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 03:18:25.141319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-16 03:18:25.141587) ========= /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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:25 INFO - MultiFileLogger online at 20170916 03:18:25 in /builds/slave/test 03:18:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:18:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:25 INFO - {'append_to_log': False, 03:18:25 INFO - 'base_work_dir': '/builds/slave/test', 03:18:25 INFO - 'blob_upload_branch': 'Firefox', 03:18:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:25 INFO - 'branch': 'Firefox', 03:18:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:25 INFO - 'code_coverage': False, 03:18:25 INFO - 'config_files': ('talos/linux_config.py',), 03:18:25 INFO - 'default_actions': ('clobber', 03:18:25 INFO - 'read-buildbot-config', 03:18:25 INFO - 'download-and-extract', 03:18:25 INFO - 'populate-webroot', 03:18:25 INFO - 'create-virtualenv', 03:18:25 INFO - 'install', 03:18:25 INFO - 'setup-mitmproxy', 03:18:25 INFO - 'run-tests'), 03:18:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:25 INFO - 'disable_ccov_upload': False, 03:18:25 INFO - 'disable_stylo': False, 03:18:25 INFO - 'download_minidump_stackwalk': True, 03:18:25 INFO - 'download_symbols': 'ondemand', 03:18:25 INFO - 'enable_stylo': False, 03:18:25 INFO - 'enable_webrender': False, 03:18:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:18:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:25 INFO - 'gecko_profile': False, 03:18:25 INFO - 'gecko_profile_interval': 0, 03:18:25 INFO - 'installer_path': 'installer.exe', 03:18:25 INFO - 'log_level': 'info', 03:18:25 INFO - 'log_name': 'talos', 03:18:25 INFO - 'log_to_console': True, 03:18:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:25 INFO - 'opt_config_files': (), 03:18:25 INFO - 'pip_index': False, 03:18:25 INFO - 'suite': 'dromaeojs-e10s', 03:18:25 INFO - 'system_bits': '32', 03:18:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:25 INFO - 'title': 'talos-linux64-ix-010', 03:18:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:25 INFO - 'use_talos_json': True, 03:18:25 INFO - 'verify': 'False', 03:18:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:25 INFO - 'work_dir': 'build'} 03:18:25 INFO - [mozharness: 2017-09-16 10:18:25.382999Z] Running clobber step. 03:18:25 INFO - Running pre-action listener: _resource_record_pre_action 03:18:25 INFO - Running main action method: clobber 03:18:25 INFO - rmtree: /builds/slave/test/build 03:18:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:26 INFO - Running post-action listener: _resource_record_post_action 03:18:26 INFO - [mozharness: 2017-09-16 10:18:26.338111Z] Finished clobber step (success) 03:18:26 INFO - [mozharness: 2017-09-16 10:18:26.338208Z] Running read-buildbot-config step. 03:18:26 INFO - Running pre-action listener: _resource_record_pre_action 03:18:26 INFO - Running main action method: read_buildbot_config 03:18:26 INFO - Using buildbot properties: 03:18:26 INFO - { 03:18:26 INFO - "project": "", 03:18:26 INFO - "product": "firefox", 03:18:26 INFO - "who": "archaeopteryx@coole-files.de", 03:18:26 INFO - "installer_path": "public/build/target.tar.bz2", 03:18:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:18:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:18:26 INFO - "stage_platform": "linux64-pgo", 03:18:26 INFO - "basedir": "/builds/slave/test", 03:18:26 INFO - "buildnumber": 167, 03:18:26 INFO - "platform": "ubuntu64_hw", 03:18:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:18:26 INFO - "slavebuilddir": "test", 03:18:26 INFO - "taskId": "HwkK6p30RX-DskneRt_kdA", 03:18:26 INFO - "branch": "mozilla-central", 03:18:26 INFO - "script_repo_revision": "production", 03:18:26 INFO - "revision": "c99a1520c7a5af8f3769d3a4fce38697ce47cbb2", 03:18:26 INFO - "slavename": "talos-linux64-ix-010", 03:18:26 INFO - "repo_path": "mozilla-central" 03:18:26 INFO - } 03:18:26 INFO - Finding installer, test and symbols from parent task. 03:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HwkK6p30RX-DskneRt_kdA'}, attempt #1 03:18:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HwkK6p30RX-DskneRt_kdA'}, attempt #1 03:18:27 INFO - Task dependencies: eeN62VmkRCGh69wutWtSzA 03:18:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA'}, attempt #1 03:18:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 03:18:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.test_packages.json 03:18:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.crashreporter-symbols.zip 03:18:27 INFO - Running post-action listener: _resource_record_post_action 03:18:27 INFO - [mozharness: 2017-09-16 10:18:27.700460Z] Finished read-buildbot-config step (success) 03:18:27 INFO - [mozharness: 2017-09-16 10:18:27.700677Z] Running download-and-extract step. 03:18:27 INFO - Running pre-action listener: _resource_record_pre_action 03:18:27 INFO - Running main action method: download_and_extract 03:18:27 INFO - mkdir: /builds/slave/test/build/tests 03:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:27 INFO - trying https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.test_packages.json 03:18:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:18:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:18:28 INFO - Downloaded 989 bytes. 03:18:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:18:28 INFO - Using the following test package requirements: 03:18:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:18:28 INFO - u'common': [u'target.common.tests.zip'], 03:18:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:18:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:18:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:18:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:18:28 INFO - u'mozbase': [u'target.common.tests.zip'], 03:18:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:18:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:18:28 INFO - u'web-platform': [u'target.common.tests.zip', 03:18:28 INFO - u'target.web-platform.tests.tar.gz'], 03:18:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:18:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.common.tests.zip 03:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.common.tests.zip into memory 03:18:30 INFO - Content-Length response header: 55323422 03:18:30 INFO - Bytes received: 55323422 03:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.talos.tests.zip 03:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:18:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.talos.tests.zip into memory 03:18:42 INFO - Content-Length response header: 14508749 03:18:42 INFO - Bytes received: 14508749 03:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:42 INFO - trying https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 03:18:42 INFO - Downloading https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:18:45 INFO - Downloaded 62140078 bytes. 03:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 03:18:46 INFO - mkdir: /builds/slave/test/properties 03:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:46 INFO - Contents: 03:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 03:18:46 INFO - Running post-action listener: _resource_record_post_action 03:18:46 INFO - Running post-action listener: find_tests_for_verification 03:18:46 INFO - Running post-action listener: set_extra_try_arguments 03:18:46 INFO - [mozharness: 2017-09-16 10:18:46.991097Z] Finished download-and-extract step (success) 03:18:46 INFO - [mozharness: 2017-09-16 10:18:46.991326Z] Running populate-webroot step. 03:18:46 INFO - Running pre-action listener: _resource_record_pre_action 03:18:46 INFO - Running main action method: populate_webroot 03:18:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['tresize', 03:18:47 INFO - 'tcanvasmark']}, 03:18:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['dromaeo_css', 03:18:47 INFO - 'kraken']}, 03:18:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'tests': ['damp', 'tps']}, 03:18:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['damp', 'tps']}, 03:18:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['dromaeo_dom']}, 03:18:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:18:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['basic_compositor_video', 03:18:47 INFO - 'glvideo']}, 03:18:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:18:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['ts_paint_webext', 03:18:47 INFO - 'tp5o_webext']}, 03:18:47 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:47 INFO - 'ts_paint', 03:18:47 INFO - 'tpaint', 03:18:47 INFO - 'sessionrestore', 03:18:47 INFO - 'sessionrestore_many_windows', 03:18:47 INFO - 'sessionrestore_no_auto_restore', 03:18:47 INFO - 'tabpaint']}, 03:18:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['a11yr', 03:18:47 INFO - 'ts_paint', 03:18:47 INFO - 'tpaint', 03:18:47 INFO - 'sessionrestore', 03:18:47 INFO - 'sessionrestore_many_windows', 03:18:47 INFO - 'sessionrestore_no_auto_restore', 03:18:47 INFO - 'tabpaint']}, 03:18:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:18:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:18:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['perf_reftest_singletons']}, 03:18:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['bloom_basic']}, 03:18:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:47 INFO - 'tsvgr_opacity', 03:18:47 INFO - 'tart', 03:18:47 INFO - 'tscrollx', 03:18:47 INFO - 'tsvg_static']}, 03:18:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['tsvgx', 03:18:47 INFO - 'tsvgr_opacity', 03:18:47 INFO - 'tart', 03:18:47 INFO - 'tscrollx', 03:18:47 INFO - 'tsvg_static']}, 03:18:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:18:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo'], 03:18:47 INFO - 'tests': ['tp5o']}, 03:18:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:47 INFO - 'talos_options': ['--mitmproxy', 03:18:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:47 INFO - '--firstNonBlankPaint'], 03:18:47 INFO - 'tests': ['tp6_google', 03:18:47 INFO - 'tp6_youtube', 03:18:47 INFO - 'tp6_amazon', 03:18:47 INFO - 'tp6_facebook']}, 03:18:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo', 03:18:47 INFO - '--mitmproxy', 03:18:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:47 INFO - '--firstNonBlankPaint'], 03:18:47 INFO - 'tests': ['tp6_google', 03:18:47 INFO - 'tp6_youtube', 03:18:47 INFO - 'tp6_amazon', 03:18:47 INFO - 'tp6_facebook']}, 03:18:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:18:47 INFO - 'talos_options': ['--stylo-threads=1', 03:18:47 INFO - '--mitmproxy', 03:18:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:18:47 INFO - '--firstNonBlankPaint'], 03:18:47 INFO - 'tests': ['tp6_google', 03:18:47 INFO - 'tp6_youtube', 03:18:47 INFO - 'tp6_amazon', 03:18:47 INFO - 'tp6_facebook']}, 03:18:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--xperf_path', 03:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:47 INFO - 'tests': ['tp5n']}, 03:18:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:18:47 INFO - 'talos_options': ['--disable-stylo', 03:18:47 INFO - '--xperf_path', 03:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:47 INFO - 'tests': ['tp5n']}}} 03:18:47 INFO - Running post-action listener: _resource_record_post_action 03:18:47 INFO - [mozharness: 2017-09-16 10:18:47.801859Z] Finished populate-webroot step (success) 03:18:47 INFO - [mozharness: 2017-09-16 10:18:47.801952Z] Running create-virtualenv step. 03:18:47 INFO - Running pre-action listener: _resource_record_pre_action 03:18:47 INFO - Running main action method: create_virtualenv 03:18:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:18:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:18:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:18:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:50 INFO - Installing pip...............done. 03:18:50 INFO - Return code: 0 03:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:50 INFO - Reading from file tmpfile_stdout 03:18:50 INFO - Output received: 03:18:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:50 INFO - Using env: {'DISPLAY': ':0', 03:18:50 INFO - 'HOME': '/home/cltbld', 03:18:50 INFO - 'LANG': 'en_US.UTF-8', 03:18:50 INFO - 'LANGUAGE': 'en_US:en', 03:18:50 INFO - 'LOGNAME': 'cltbld', 03:18:50 INFO - 'MAIL': '/var/mail/cltbld', 03:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:50 INFO - 'MOZ_NO_REMOTE': '1', 03:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:50 INFO - 'NO_EM_RESTART': '1', 03:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:50 INFO - 'PWD': '/builds/slave/test', 03:18:50 INFO - 'SHELL': '/bin/bash', 03:18:50 INFO - 'SHLVL': '1', 03:18:50 INFO - 'TERM': 'linux', 03:18:50 INFO - 'TMOUT': '86400', 03:18:50 INFO - 'USER': 'cltbld', 03:18:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:50 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:18:51 INFO - Downloading/unpacking pip>=1.5 03:18:51 INFO - Running setup.py egg_info for package pip 03:18:51 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:51 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:51 INFO - Installing collected packages: pip 03:18:51 INFO - Found existing installation: pip 1.1 03:18:51 INFO - Uninstalling pip: 03:18:51 INFO - Successfully uninstalled pip 03:18:51 INFO - Running setup.py install for pip 03:18:51 INFO - warning: no files found matching 'pip/cacert.pem' 03:18:51 INFO - warning: no files found matching '*.html' under directory 'docs' 03:18:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:18:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:18:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:18:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:18:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:18:51 INFO - Successfully installed pip 03:18:51 INFO - Cleaning up... 03:18:51 INFO - Return code: 0 03:18:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:51 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 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:51 INFO - Using env: {'DISPLAY': ':0', 03:18:51 INFO - 'HOME': '/home/cltbld', 03:18:51 INFO - 'LANG': 'en_US.UTF-8', 03:18:51 INFO - 'LANGUAGE': 'en_US:en', 03:18:51 INFO - 'LOGNAME': 'cltbld', 03:18:51 INFO - 'MAIL': '/var/mail/cltbld', 03:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:51 INFO - 'MOZ_NO_REMOTE': '1', 03:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:51 INFO - 'NO_EM_RESTART': '1', 03:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:51 INFO - 'PWD': '/builds/slave/test', 03:18:51 INFO - 'SHELL': '/bin/bash', 03:18:51 INFO - 'SHLVL': '1', 03:18:51 INFO - 'TERM': 'linux', 03:18:51 INFO - 'TMOUT': '86400', 03:18:51 INFO - 'USER': 'cltbld', 03:18:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:51 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:51 INFO - Downloading/unpacking psutil>=3.1.1 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:53 INFO - Installing collected packages: psutil 03:18:53 INFO - Running setup.py install for psutil 03:18:53 INFO - building 'psutil._psutil_linux' extension 03:18:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:18:54 INFO - building 'psutil._psutil_posix' extension 03:18:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:54 INFO - Successfully installed psutil 03:18:54 INFO - Cleaning up... 03:18:54 INFO - Return code: 0 03:18:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:18:54 INFO - Using env: {'DISPLAY': ':0', 03:18:54 INFO - 'HOME': '/home/cltbld', 03:18:54 INFO - 'LANG': 'en_US.UTF-8', 03:18:54 INFO - 'LANGUAGE': 'en_US:en', 03:18:54 INFO - 'LOGNAME': 'cltbld', 03:18:54 INFO - 'MAIL': '/var/mail/cltbld', 03:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:54 INFO - 'MOZ_NO_REMOTE': '1', 03:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:54 INFO - 'NO_EM_RESTART': '1', 03:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:54 INFO - 'PWD': '/builds/slave/test', 03:18:54 INFO - 'SHELL': '/bin/bash', 03:18:54 INFO - 'SHLVL': '1', 03:18:54 INFO - 'TERM': 'linux', 03:18:54 INFO - 'TMOUT': '86400', 03:18:54 INFO - 'USER': 'cltbld', 03:18:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:54 INFO - '_': '/tools/buildbot/bin/python'} 03:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:56 INFO - Installing collected packages: mozsystemmonitor 03:18:56 INFO - Running setup.py install for mozsystemmonitor 03:18:56 INFO - Successfully installed mozsystemmonitor 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:57 INFO - warning: no files found matching '*.txt' 03:18:57 INFO - no previously-included directories found matching 'build' 03:18:57 INFO - no previously-included directories found matching 'dist' 03:18:57 INFO - no previously-included directories found matching '.git*' 03:18:57 INFO - Installing collected packages: jsonschema, functools32 03:18:57 INFO - Running setup.py install for functools32 03:18:57 INFO - warning: no files found matching '*.txt' 03:18:57 INFO - no previously-included directories found matching 'build' 03:18:57 INFO - no previously-included directories found matching 'dist' 03:18:57 INFO - no previously-included directories found matching '.git*' 03:18:57 INFO - Successfully installed jsonschema functools32 03:18:57 INFO - Cleaning up... 03:18:58 INFO - Return code: 0 03:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:58 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 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:18:58 INFO - Using env: {'DISPLAY': ':0', 03:18:58 INFO - 'HOME': '/home/cltbld', 03:18:58 INFO - 'LANG': 'en_US.UTF-8', 03:18:58 INFO - 'LANGUAGE': 'en_US:en', 03:18:58 INFO - 'LOGNAME': 'cltbld', 03:18:58 INFO - 'MAIL': '/var/mail/cltbld', 03:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:58 INFO - 'MOZ_NO_REMOTE': '1', 03:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:58 INFO - 'NO_EM_RESTART': '1', 03:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:58 INFO - 'PWD': '/builds/slave/test', 03:18:58 INFO - 'SHELL': '/bin/bash', 03:18:58 INFO - 'SHLVL': '1', 03:18:58 INFO - 'TERM': 'linux', 03:18:58 INFO - 'TMOUT': '86400', 03:18:58 INFO - 'USER': 'cltbld', 03:18:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:58 INFO - '_': '/tools/buildbot/bin/python'} 03:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:58 INFO - Cleaning up... 03:18:58 INFO - Return code: 0 03:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:58 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 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:18:58 INFO - Using env: {'DISPLAY': ':0', 03:18:58 INFO - 'HOME': '/home/cltbld', 03:18:58 INFO - 'LANG': 'en_US.UTF-8', 03:18:58 INFO - 'LANGUAGE': 'en_US:en', 03:18:58 INFO - 'LOGNAME': 'cltbld', 03:18:58 INFO - 'MAIL': '/var/mail/cltbld', 03:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:58 INFO - 'MOZ_NO_REMOTE': '1', 03:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:58 INFO - 'NO_EM_RESTART': '1', 03:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:58 INFO - 'PWD': '/builds/slave/test', 03:18:58 INFO - 'SHELL': '/bin/bash', 03:18:58 INFO - 'SHLVL': '1', 03:18:58 INFO - 'TERM': 'linux', 03:18:58 INFO - 'TMOUT': '86400', 03:18:58 INFO - 'USER': 'cltbld', 03:18:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:58 INFO - '_': '/tools/buildbot/bin/python'} 03:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:00 INFO - Downloading docopt-0.6.1.tar.gz 03:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:19:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:19:00 INFO - Running setup.py install for blobuploader 03:19:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:19:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:19:00 INFO - Running setup.py install for requests 03:19:00 INFO - Running setup.py install for docopt 03:19:00 INFO - Successfully installed blobuploader requests docopt 03:19:00 INFO - Cleaning up... 03:19:00 INFO - Return code: 0 03:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:00 INFO - Using env: {'DISPLAY': ':0', 03:19:00 INFO - 'HOME': '/home/cltbld', 03:19:00 INFO - 'LANG': 'en_US.UTF-8', 03:19:00 INFO - 'LANGUAGE': 'en_US:en', 03:19:00 INFO - 'LOGNAME': 'cltbld', 03:19:00 INFO - 'MAIL': '/var/mail/cltbld', 03:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:00 INFO - 'MOZ_NO_REMOTE': '1', 03:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:00 INFO - 'NO_EM_RESTART': '1', 03:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:00 INFO - 'PWD': '/builds/slave/test', 03:19:00 INFO - 'SHELL': '/bin/bash', 03:19:00 INFO - 'SHLVL': '1', 03:19:00 INFO - 'TERM': 'linux', 03:19:00 INFO - 'TMOUT': '86400', 03:19:00 INFO - 'USER': 'cltbld', 03:19:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:00 INFO - '_': '/tools/buildbot/bin/python'} 03:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:00 INFO - Running setup.py (path:/tmp/pip-XnF0od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:01 INFO - Running setup.py (path:/tmp/pip-jVV_yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:01 INFO - Running setup.py (path:/tmp/pip-OqcuCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:01 INFO - Running setup.py (path:/tmp/pip-UqVl84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:01 INFO - Running setup.py (path:/tmp/pip-skXDpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:01 INFO - Running setup.py (path:/tmp/pip-P5uXfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:01 INFO - Running setup.py (path:/tmp/pip-XV6xU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:01 INFO - Running setup.py (path:/tmp/pip-jBupVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:01 INFO - Running setup.py (path:/tmp/pip-DxMhqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:01 INFO - Running setup.py (path:/tmp/pip-tgw5zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:01 INFO - Running setup.py (path:/tmp/pip-rCzM7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:01 INFO - Running setup.py (path:/tmp/pip-LS6X7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:01 INFO - Running setup.py (path:/tmp/pip-8cTstJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:01 INFO - Running setup.py (path:/tmp/pip-tguJ6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:01 INFO - Running setup.py (path:/tmp/pip-sOCFh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:02 INFO - Running setup.py (path:/tmp/pip-RKxQoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:02 INFO - Running setup.py (path:/tmp/pip-6Yk8Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:02 INFO - Running setup.py install for manifestparser 03:19:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozcrash 03:19:02 INFO - Running setup.py install for mozdebug 03:19:02 INFO - Running setup.py install for mozdevice 03:19:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozfile 03:19:02 INFO - Running setup.py install for mozhttpd 03:19:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozinfo 03:19:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozInstall 03:19:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozleak 03:19:03 INFO - Running setup.py install for mozlog 03:19:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Running setup.py install for moznetwork 03:19:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Running setup.py install for mozprocess 03:19:03 INFO - Running setup.py install for mozprofile 03:19:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Running setup.py install for mozrunner 03:19:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Running setup.py install for mozscreenshot 03:19:03 INFO - Running setup.py install for moztest 03:19:03 INFO - Running setup.py install for mozversion 03:19:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:03 INFO - Cleaning up... 03:19:03 INFO - Return code: 0 03:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19: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')]} 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:03 INFO - Using env: {'DISPLAY': ':0', 03:19:03 INFO - 'HOME': '/home/cltbld', 03:19:03 INFO - 'LANG': 'en_US.UTF-8', 03:19:03 INFO - 'LANGUAGE': 'en_US:en', 03:19:03 INFO - 'LOGNAME': 'cltbld', 03:19:03 INFO - 'MAIL': '/var/mail/cltbld', 03:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:03 INFO - 'MOZ_NO_REMOTE': '1', 03:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:03 INFO - 'NO_EM_RESTART': '1', 03:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:03 INFO - 'PWD': '/builds/slave/test', 03:19:03 INFO - 'SHELL': '/bin/bash', 03:19:03 INFO - 'SHLVL': '1', 03:19:03 INFO - 'TERM': 'linux', 03:19:03 INFO - 'TMOUT': '86400', 03:19:03 INFO - 'USER': 'cltbld', 03:19:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:03 INFO - '_': '/tools/buildbot/bin/python'} 03:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:04 INFO - Running setup.py (path:/tmp/pip-0srP2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:04 INFO - Running setup.py (path:/tmp/pip-ZSuNOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:04 INFO - Running setup.py (path:/tmp/pip-YSQTtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:04 INFO - Running setup.py (path:/tmp/pip-4IBKuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:04 INFO - Running setup.py (path:/tmp/pip-KjRPPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:04 INFO - Running setup.py (path:/tmp/pip-gUFpb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:04 INFO - Running setup.py (path:/tmp/pip-m2C3xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:04 INFO - Running setup.py (path:/tmp/pip-rd7i7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:04 INFO - Running setup.py (path:/tmp/pip-Ecql75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:04 INFO - Running setup.py (path:/tmp/pip-sccH9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:04 INFO - Running setup.py (path:/tmp/pip-CbwOCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:04 INFO - Running setup.py (path:/tmp/pip-aOyiDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:04 INFO - Running setup.py (path:/tmp/pip-U158T1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:05 INFO - Running setup.py (path:/tmp/pip-do7WbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:05 INFO - Running setup.py (path:/tmp/pip-oyfNau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:05 INFO - Running setup.py (path:/tmp/pip-paNWrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:05 INFO - Running setup.py (path:/tmp/pip-MmY89U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:19:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:06 INFO - Downloading blessings-1.6.tar.gz 03:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:06 INFO - Installing collected packages: blessings 03:19:06 INFO - Running setup.py install for blessings 03:19:06 INFO - Successfully installed blessings 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:06 INFO - Reading from file tmpfile_stdout 03:19:06 INFO - Current package versions: 03:19:06 INFO - argparse == 1.2.1 03:19:06 INFO - blessings == 1.6 03:19:06 INFO - blobuploader == 1.2.4 03:19:06 INFO - docopt == 0.6.1 03:19:06 INFO - functools32 == 3.2.3-2 03:19:06 INFO - jsonschema == 2.5.1 03:19:06 INFO - manifestparser == 1.1 03:19:06 INFO - mozInstall == 1.13 03:19:06 INFO - mozcrash == 1.0 03:19:06 INFO - mozdebug == 0.1 03:19:06 INFO - mozdevice == 0.51 03:19:06 INFO - mozfile == 1.2 03:19:06 INFO - mozhttpd == 0.7 03:19:06 INFO - mozinfo == 0.10 03:19:06 INFO - mozleak == 0.1 03:19:06 INFO - mozlog == 3.5 03:19:06 INFO - moznetwork == 0.27 03:19:06 INFO - mozprocess == 0.25 03:19:06 INFO - mozprofile == 0.28 03:19:06 INFO - mozrunner == 6.13 03:19:06 INFO - mozscreenshot == 0.1 03:19:06 INFO - mozsystemmonitor == 0.3 03:19:06 INFO - moztest == 0.8 03:19:06 INFO - mozversion == 1.4 03:19:06 INFO - psutil == 3.1.1 03:19:06 INFO - requests == 1.2.3 03:19:06 INFO - wsgiref == 0.1.2 03:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:19:06 INFO - Using env: {'DISPLAY': ':0', 03:19:06 INFO - 'HOME': '/home/cltbld', 03:19:06 INFO - 'LANG': 'en_US.UTF-8', 03:19:06 INFO - 'LANGUAGE': 'en_US:en', 03:19:06 INFO - 'LOGNAME': 'cltbld', 03:19:06 INFO - 'MAIL': '/var/mail/cltbld', 03:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:06 INFO - 'MOZ_NO_REMOTE': '1', 03:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:06 INFO - 'NO_EM_RESTART': '1', 03:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:06 INFO - 'PWD': '/builds/slave/test', 03:19:06 INFO - 'SHELL': '/bin/bash', 03:19:06 INFO - 'SHLVL': '1', 03:19:06 INFO - 'TERM': 'linux', 03:19:06 INFO - 'TMOUT': '86400', 03:19:06 INFO - 'USER': 'cltbld', 03:19:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:06 INFO - '_': '/tools/buildbot/bin/python'} 03:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:19:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:19:08 INFO - Installing collected packages: simplejson 03:19:08 INFO - Running setup.py install for simplejson 03:19:08 INFO - building 'simplejson._speedups' extension 03:19:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:19:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:19:09 INFO - Successfully installed simplejson 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:09 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 0x9e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, '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': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:19:09 INFO - Using env: {'DISPLAY': ':0', 03:19:09 INFO - 'HOME': '/home/cltbld', 03:19:09 INFO - 'LANG': 'en_US.UTF-8', 03:19:09 INFO - 'LANGUAGE': 'en_US:en', 03:19:09 INFO - 'LOGNAME': 'cltbld', 03:19:09 INFO - 'MAIL': '/var/mail/cltbld', 03:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:09 INFO - 'MOZ_NO_REMOTE': '1', 03:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:09 INFO - 'NO_EM_RESTART': '1', 03:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:09 INFO - 'PWD': '/builds/slave/test', 03:19:09 INFO - 'SHELL': '/bin/bash', 03:19:09 INFO - 'SHLVL': '1', 03:19:09 INFO - 'TERM': 'linux', 03:19:09 INFO - 'TMOUT': '86400', 03:19:09 INFO - 'USER': 'cltbld', 03:19:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:09 INFO - '_': '/tools/buildbot/bin/python'} 03:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:09 INFO - Cleaning up... 03:19:09 INFO - Return code: 0 03:19:09 INFO - Running post-action listener: _resource_record_post_action 03:19:09 INFO - Running post-action listener: _start_resource_monitoring 03:19:09 INFO - Starting resource monitoring. 03:19:09 INFO - [mozharness: 2017-09-16 10:19:09.664682Z] Finished create-virtualenv step (success) 03:19:09 INFO - [mozharness: 2017-09-16 10:19:09.665809Z] Running install step. 03:19:09 INFO - Running pre-action listener: _resource_record_pre_action 03:19:09 INFO - Running main action method: install 03:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:09 INFO - Reading from file tmpfile_stdout 03:19:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:10 INFO - Reading from file tmpfile_stdout 03:19:10 INFO - Output received: 03:19:10 INFO - Usage: mozinstall [options] installer 03:19:10 INFO - Options: 03:19:10 INFO - -h, --help show this help message and exit 03:19:10 INFO - -d DEST, --destination=DEST 03:19:10 INFO - Directory to install application into. [default: 03:19:10 INFO - "/builds/slave/test"] 03:19:10 INFO - --app=APP Application being installed. [default: firefox] 03:19:10 INFO - mkdir: /builds/slave/test/build/application 03:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:19:27 INFO - Reading from file tmpfile_stdout 03:19:27 INFO - Output received: 03:19:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:27 INFO - Running post-action listener: _resource_record_post_action 03:19:27 INFO - [mozharness: 2017-09-16 10:19:27.588511Z] Finished install step (success) 03:19:27 INFO - [mozharness: 2017-09-16 10:19:27.588659Z] Running setup-mitmproxy step. 03:19:27 INFO - Running pre-action listener: _resource_record_pre_action 03:19:27 INFO - Running main action method: setup_mitmproxy 03:19:27 INFO - Skipping: mitmproxy is not required 03:19:27 INFO - Running post-action listener: _resource_record_post_action 03:19:27 INFO - [mozharness: 2017-09-16 10:19:27.589407Z] Finished setup-mitmproxy step (success) 03:19:27 INFO - [mozharness: 2017-09-16 10:19:27.589626Z] Running run-tests step. 03:19:27 INFO - Running pre-action listener: _resource_record_pre_action 03:19:27 INFO - Running pre-action listener: _set_gcov_prefix 03:19:27 INFO - Running main action method: run_tests 03:19:27 WARNING - Try message not found. 03:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:27 INFO - Python 2.7.3 03:19:27 INFO - Return code: 0 03:19:27 INFO - grabbing minidump binary from tooltool 03:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd53090>, '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 0xd53d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:19:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:19:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:19:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:27 INFO - Return code: 0 03:19:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:27 INFO - ENV: RUST_BACKTRACE is now full 03:19:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:19:27 INFO - Using env: {'DISPLAY': ':0', 03:19:27 INFO - 'HOME': '/home/cltbld', 03:19:27 INFO - 'LANG': 'en_US.UTF-8', 03:19:27 INFO - 'LANGUAGE': 'en_US:en', 03:19:27 INFO - 'LOGNAME': 'cltbld', 03:19:27 INFO - 'MAIL': '/var/mail/cltbld', 03:19:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:27 INFO - 'MOZ_NO_REMOTE': '1', 03:19:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:27 INFO - 'NO_EM_RESTART': '1', 03:19:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:27 INFO - 'PWD': '/builds/slave/test', 03:19:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:27 INFO - 'RUST_BACKTRACE': 'full', 03:19:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:27 INFO - 'SHELL': '/bin/bash', 03:19:27 INFO - 'SHLVL': '1', 03:19:27 INFO - 'TERM': 'linux', 03:19:27 INFO - 'TMOUT': '86400', 03:19:27 INFO - 'USER': 'cltbld', 03:19:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:27 INFO - '_': '/tools/buildbot/bin/python'} 03:19:27 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/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:19:28 INFO - mozversion application_buildid: 20170916085847 03:19:28 INFO - mozversion application_changeset: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 03:19:28 INFO - mozversion application_display_name: Nightly 03:19:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:28 INFO - mozversion application_name: Firefox 03:19:28 INFO - mozversion application_remotingname: firefox 03:19:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:19:28 INFO - mozversion application_vendor: Mozilla 03:19:28 INFO - mozversion application_version: 57.0a1 03:19:28 INFO - mozversion platform_buildid: 20170916085847 03:19:28 INFO - mozversion platform_changeset: c99a1520c7a5af8f3769d3a4fce38697ce47cbb2 03:19:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:19:28 INFO - mozversion platform_version: 57.0a1 03:19:28 INFO - using testdate: 1505557168 03:19:28 INFO - actual date: 1505557168 03:19:28 INFO - starting webserver on 'localhost:33056' 03:19:28 INFO - SUITE-START | Running 2 tests 03:19:28 INFO - TEST-START | dromaeo_css 03:19:28 INFO - Initialising browser for dromaeo_css test... 03:19:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33056/getInfo.html -profile /tmp/tmpQ0D6MY/profile 03:19:28 INFO - TEST-INFO | started process 3620 (/builds/slave/test/build/application/firefox/firefox http://localhost:33056/getInfo.html) 03:19:39 INFO - TEST-INFO | 3620: exit 0 03:19:39 INFO - Browser initialized. 03:19:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:39 INFO - Using env: {'DISPLAY': ':0', 03:19:39 INFO - 'HOME': '/home/cltbld', 03:19:39 INFO - 'JSGC_DISABLE_POISONING': '1', 03:19:39 INFO - 'LANG': 'en_US.UTF-8', 03:19:39 INFO - 'LANGUAGE': 'en_US:en', 03:19:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:19:39 INFO - 'LOGNAME': 'cltbld', 03:19:39 INFO - 'MAIL': '/var/mail/cltbld', 03:19:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:39 INFO - 'MOZ_CRASHREPORTER': '1', 03:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:19:39 INFO - 'MOZ_NO_REMOTE': '1', 03:19:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:39 INFO - 'NO_EM_RESTART': '1', 03:19:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:39 INFO - 'PWD': '/builds/slave/test', 03:19:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:39 INFO - 'RUST_BACKTRACE': 'full', 03:19:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:39 INFO - 'SHELL': '/bin/bash', 03:19:39 INFO - 'SHLVL': '1', 03:19:39 INFO - 'TERM': 'linux', 03:19:39 INFO - 'TMOUT': '86400', 03:19:39 INFO - 'USER': 'cltbld', 03:19:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:39 INFO - '_': '/tools/buildbot/bin/python'} 03:19:39 INFO - TEST-INFO | started process 3858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0D6MY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:40 INFO - PID 3858 | 03:19:40 INFO - PID 3858 | (/builds/slave/test/build/application/firefox/firefox:3908): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:40 INFO - PID 3858 | 03:19:50 INFO - PID 3858 | RSS: Main: 164843520 03:19:50 INFO - PID 3858 | 03:22:47 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33056/tests/dromaeo/cssquery-ext.html) 03:22:48 INFO - PID 3858 | RSS: Main: 168570880 03:22:48 INFO - PID 3858 | 03:25:50 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-ext.html (next: http://localhost:33056/tests/dromaeo/cssquery-jquery.html) 03:25:50 INFO - PID 3858 | RSS: Main: 164675584 03:25:50 INFO - PID 3858 | 03:28:52 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33056/tests/dromaeo/cssquery-mootools.html) 03:28:52 INFO - PID 3858 | RSS: Main: 167038976 03:28:52 INFO - PID 3858 | 03:31:54 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33056/tests/dromaeo/cssquery-prototype.html) 03:31:55 INFO - PID 3858 | RSS: Main: 164204544 03:31:55 INFO - PID 3858 | 03:34:58 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33056/tests/dromaeo/cssquery-yui.html) 03:34:58 INFO - PID 3858 | RSS: Main: 167006208 03:34:58 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | Cycle 1(1): loaded http://localhost:33056/tests/dromaeo/cssquery-yui.html (next: http://localhost:33056/tests/dromaeo/cssquery-dojo.html) 03:38:00 INFO - PID 3858 | RSS: Main: 168337408 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | __start_tp_report 03:38:00 INFO - PID 3858 | _x_x_mozilla_page_load 03:38:00 INFO - PID 3858 | _x_x_mozilla_page_load_details 03:38:00 INFO - PID 3858 | |i|pagename|runs| 03:38:00 INFO - PID 3858 | |0;dojo.html;3827.425886117082;3852.268069066877;3860.671842893355;3863.227354529093;3895.240428116515;6234.719437625306;6332.081848132029;6355.269144048436;6362.58643188193;6364.777232796847;6220.533459990496;6328.493720502361;6329.430351268385;6336.588121772082;6348.333424990367;5559.305086864142;5560.666360018392;5576.33084029915;5609.046462101453;5666.178404131399;5619.129034999562;5685.857853553653;5692.8861422771515;5704.172894930232;5714.857128571798;582.8453636270968;5536.031194540939;5544.251526043993;5617.157426386034;5647.915281270784;5470.890582188374;5558.555315574744;5629.577781666391;5633.492985631272;5637.267155269829;5392.91910621341;5457.617966742329;5476.26070480484;5488.313960754906;5539.002979463695;6234.625922444668;6250.9062364064575;6281.748730050793;6298.748050077991;6337.683115844189;6782.559133656297;6794.864102717967;6866.828329291758;6869.072675188835;6880.483963702743;6744.494162937799;6797.116374871284;6871.072405225281;6880.65596720162;6886.758963436256;6304.810855674337;6309.179806625155;6340.112384266206;6353.523485738542;6390.297067322591;7056.2238153803555;7109.92890071103;7118.323759242864;7130.857382852314;7133.894246391817;6738.494612904052;6741.460683145337;6809.863802723918;6820.079289295882;6822.692978815965;6663.233728121231;6793.354631310018;6843.486738494633;6864.38220560142;6944.583325000516;6658.03458498515;6778.017187507784;6789.388954994074;6795.72817087311;6803.115594972622;6741.966290168518;6777;6849.417799487;6849.897251541231;6856.177258728984;4896.779644915988;4921.975390123026;4934.703917764946;4971.825986090469;4978.079055374767;4511.120331535385;4516.254817955;4529.252673308867;4539.977300113478;4543.295789152687;6305.117283580303;6337.207849018872;6415.839604009937;6416.839579010469;6424.646644434601;6731.32686731323;6805.4895882808;6821.283765204582;6861.245263021064;6929.1684997799575;6276.278228003746;6298.7480500780375;6332.556721029576;6333.493320534346;6333.8733225336155;5536.612437129443;5549.528290095306;5568.554515638739;5572.777088916479;5575.553955683536;6982.61595612236;7093.822654433578;7178.17450993132;7195;7215.314545118205;6664.233613134552;6731.899021514779;6754.493412994045;6827.658617069027;6846.144231971004;7099.43204543625;7183.8563228736175;7209.134903811367;7224;7230.783076507713;6737.461003119836;6737.562058466184;6813.693383797642;6822.590644561342;6838.350356716104;6851.835188017949;6867.587944723133;6951.061606683235;6957.443404527525;6960.129983752031;6503.902441463477;6563.113979612882;6573.079768832272;6596.175478065242;6663.300353462817;6494.577852439576;6535.967320163369;6545;6547.9672601638595;6565.540412171103;6356.396142366468;6366.9681651591445;6426.843168229763;6450.419462248233;6453.290138084713;6649.202095748541;6692.063111164343;6712.597244165366;6720.731170753115;6730.629815360202;6422.3577642235405;6438.356164383524;6458.709358078804;6526.575772574957;6530.216374035146 03:38:00 INFO - PID 3858 | |1;ext.html;932.1750251027843;956.8947415784264;973.3040875773822;986.5609803637384;989.8812142542891;43295.35056974148;44180.337294940604;44815.551844481546;44897.77551112248;45155.77422112893;42185.78907105468;42417.78791106048;42494;42517.57482425175;42579.78710106453;7492.700291988314;7579.81050473737;7588.089429268468;7614.809629759245;7620.161782203953;7366.931794889738;7454.664540095681;7458.10502739672;7465.589392583406;7465.813354666149;7444.925550744478;7923.96038019812;8018.398620103487;8036.598170091501;8036.879446808302;7938.325242354407;7988.121306656263;7992.720254791113;7992.880106798402;8001.079875814268;7683.961580192064;7774.65014074368;7781.844363112763;7795.61021948906;7963.1638677939145;42101.78949105265;42448.575514244774;42567.787161064;42600.360994585106;42616.57383426157;3690.2066055797864;3738.9439158412647;3739.476473293741;3739.5886452490204;3742.5696044954907;34339;34424.82787586071;34494.13764655879;34503.82748086269;34534.82732586321;5524.475174858382;5534.723263836832;5562.638428502134;5568.081266591008;5617.494425501724;204880;208227;215696;219271;263177.9999999981;52228.21657675138;52953.2057019145;53021.73489132529;53457.732711336976;53534;55366.44633553613;55602;55663.72168139214;55668.443315567136;55944.72027639836;14750.336234869243;14776.335064922105;14791.260436978107;14847.777283340758;14957.925210373878;11796.646100616996;11898.762024759457;11932.28406295625;11941.761164776655;11948.522059117711;14388.640283992774;14590.197539135237;14599.270036498132;14760;14831.258437078102;5919.881602368015;6095.177151084636;6102;6115.602485838406;6137.662428566472;1086.5219303506433;1093.8796732359592;1106.7620461600795;1111.7331840358256;1142.2061667141422;25074.623880641804;25290.494190116096;25310.873445632653;25411;25468.617970730083;1172.6130376975577;1179.4574495731888;1180.397997021508;1180.7166280092715;1194.940252987347;13195.110258868663;13428.865711342956;13462.057655964185;13502.729945401037;13561.525346612822;286149;288095;290112;292998;293901;55705.44294557002;56267.15599266014;59925.700371497864;60761;61028.38971610227;1440.4454285100312;1470.8161479815024;1471.977920331196;1472.7159726538223;1500.0699566268984;29132.854335729033;29468;30027;30062.3987520244;30594.388112238077;40284.59715402926;40717.1856562873;40813;40847;40930.59069409268;238436;239229;240100;240913;241927;38161.23677526379;39478;39686.801565991984;39883;40219.39670904997;48141.27788083111;49561.75219123881;49706;49879.501204987486;50014;35950.460743089396;36268.818655907606;36396;36414.63585364113;36573.634263657026;36273.45589816208;36396.27207455889;36426.4536031965;36491.817540912125;36626.633733662326;42069;42188;42225.36661950012;42418.57581424146;42522.57477425186;34769.47845782366;34880;35218.11954701153;35238.29523409569;35241;26534.336641584116;26685.332866678487;26740.8662956684;26781;27096.1871143866 03:38:00 INFO - PID 3858 | |2;jquery.html;583.9678817665027;584.2346526050876;586.9119632055194;601.5638661970071;602.8492876780804;22845.4288642784;23688.289351319465;23762.64356034661;23764.76235237647;23790;24208.636870446957;24869.25392238231;26123.608145877828;26275.86862065687;26302;6687.933120668779;6868.793936181897;6870.519063665545;6871;6897.068895699092;6412;6705.228898676642;6737.629430381327;6781.830454238659;6822.351876571743;6593.505487088463;6600.570962887421;6658.434033107192;6659.467242620579;6659.467242620579;6661.26726060133;6662.233843108056;6667.066610674485;6668.266490686045;6668.9666551667415;6169.876602467925;6370.362963703639;6370.840728981812;6373.075903993895;6393.712282947232;29864.701352986627;30229.546556801666;30355.544666830014;30447.69552304471;30553.083407497812;2160.179131929857;2182.8362872784605;2182.890855457221;2183.4977955070262;2191.9561608767895;20954.895225523927;21100.788992110036;21479.140834366608;21773.2379366723;22017.11931522737;2444.767747064026;2451.8651474168914;2502;2513.7988960883085;2540.5681034224226;132263;138640.92038619428;139390;144488;151158;15608.765868511982;16184.271707773178;16220.351185952666;16251.756223656655;16559.586010349598;24978;25006;25014.37464063413;25041.12356067529;25102.748972510406;10128.240381971382;10130.645427410152;10162.695119146438;10339.914308997448;10351.861295257515;9245.399049061789;9276.16514513697;9307.208887244524;9314.301427392973;9340.626374945063;9718.465484398284;9776.804463910825;9894.55474503649;10067.848982265272;10192.643257485952;2902.9274268143467;2939.853007349624;2962.303858593229;2974.598429212072;3046.055722725962;1020.9642662506776;1051.7791263834526;1056.8361903904906;1060.8514807926897;1081.7457897394106;21763;21859.781402186094;21963.560728785335;22039.779602203773;22126.446838828837;1091.317926296065;1101.1906248907046;1101.3777215873006;1102.2669924500278;1112.933224006562;11907.702307442383;12001.63995080149;12099.395030248452;12144.878551214375;12237.694057648452;575139;577108;590888;629882;633801;122026;123256;125964;126666;128935;1211.3882489343002;1217.4521465340456;1246.2397937258265;1247.0958555047519;1247.6631309546372;18544.443666690022;18726.25094996185;19008.23967041303;19096.522586935436;19569.412917612495;60803;60906.39093609185;62704.37295626985;63288;63351;73032.26967730255;73965;74156.2584374171;75990.6200468994;76720;15459.845401545841;15624.453144139901;15650.530484085495;15689.529314120595;15709;24489.632655510537;24780.628290575296;24809.503809924063;25100.24699259025;25164.49671006533;19725.506862328555;19900.50248743793;20008.99955002215;20042.799572004093;20350.694739579216;17276.13619319054;17910.373136940143;17931.820681793015;18028.639427211645;18387.908060460148;18593.070346482353;18752.437426877215;18765.90617046906;18823.71764423562;19354.903225483784;15032.699346013238;15107.39570417171;15152.772708409162;15186.088834669956;15273.694526109637;19120.808791911903;19338.129784160028;19697;19713.310034148737;19721.901390492956 03:38:00 INFO - PID 3858 | |3;mootools.html;1431.4846655204126;1483.7180935622232;1500.6923580665964;1510.5317351620995;1523.7257293687132;16606.25271862766;17112.401065962695;17260.395886143986;17274.913625431855;17283.82716172838;16829.579260518494;16882.66234675306;16918.238679259433;16951.49145525636;16960.74558881618;2867.713228677131;2884;2904.4481548505823;2904.5207540755855;2929.3555417808047;2841.2044627504333;2875.683674795771;2880.7983441159126;2882.221800113968;2883.408901175254;2458.5943319352286;2643.074923776682;2665.6001599759998;2668.4129491511935;2673.051066871262;2863.3128049268234;2899.173735485387;2902.709729027091;2919.065898912349;2935.354222071141;2626.8949242030294;2702.337927207847;2707.742764437375;2712.118561467531;2724.6730392353043;16730.247138878778;16858.24137913797;16870.662586748196;16881.915590422093;16903.23935422909;8648.09195034525;8947.373683842134;8969.686060987835;8971.730848074569;8975.685850995249;5691.971540142315;5741.368449470555;5812.796552120655;5865.912011319833;5897.587168898179;2091.309867743656;2125.171183238538;2126.26643807886;2130.3928380411508;2145.6030634332697;30379.392412151854;30679;30715.539266911015;30762;30928.0721578353;7342.77971660851;7390.187079421259;7430.925690743132;7505.4746167767735;7525.924740752523;19118.2352705893;19291;19372.225110995685;19374.321898733477;19386.321478748177;8192.098869124391;8375.581220938928;8422.24199822019;8454.239118479367;8455;7498.287662672037;7573.46985711006;7696.461247712607;7697.114831794303;7803.765887023398;5660.773569057192;5788.971055144697;5790.160426738099;5836.795712150054;5938.346781853993;1682.528891910267;1691.805442374118;1700.4558541266676;1701.2259421962976;1730.6279149982813;926.0924294191595;944.9574769135405;946.8059047895165;956.321012081416;965.8406362950175;8330.458520196167;8346.4157508975;8351.874721879176;8482.491050536988;8494.575271236414;754.2495217258862;780.7579650308422;784.8979632647834;797.8284668796236;807.2290962131268;5085.847424577195;5158;5526.47498487643;5719.256496655408;6027.246594175728;23533.17633882806;24687.38281542976;25016.624750628755;25344.873275633505;25421.49157016849;24723;24744.752552474605;25175.37061573475;25437.61843572311;25680.74319256821;12331.50673973049;12492.250464971949;12645.178063425848;12753.234805911676;12761.553345632858;8858.46849189025;8887.511186884783;8979.10208979123;8987.505687187268;9133.680321188727;20811.375658730263;21477.248296309554;21593.24423645165;21610.459738506033;21747.347579572637;21491.46271343229;21750.56498869982;21808.672869906648;21959.78040219641;22173.778262217817;12327.876721233031;12500.249985000566;12519.248845069325;12522.87477125217;12538.059645526804;15570.532884013497;15978.440754573534;16047.67904641924;16053.759193611872;16072.758908616146;11838.63855656576;11885.46515406826;11901.464434100659;12161;12320.952719018625;11695.88304116948;11734.823977640172;11965.820512692142;12029.218100823418;12207.145499814927;10331.483425828828;10385.948070259601;10565.735856603646;10566.41884696349;10571.5242814072;7707.88438173439;8084.797880052811;8085.919140808516;8090.87863682057;8112.878306825521;7849;8001.759947201594;8024.799380015313;8043.87934180976;8087.63605637736 03:38:00 INFO - PID 3858 | |4;prototype.html;518.530729689631;546.2379979927999;556.6771272661856;564.5596434780871;576.2997957481659;6196.752129914804;6218.502519798417;6240.15757872687;6255.468285195758;6303.149074874902;6200.875982480347;6248.18831525814;6253.374662533744;6277.403646653572;6286;4917.680350777188;5019.472955339692;5030.421501527317;5050.393952725678;5077.6953382797055;4995.200767877141;5059.519345662156;5062.443131255559;5075.847724568269;5099.4390617032095;4946.332245146895;4953.752312384385;4968.677035992667;4978.850634480971;4993.650444468889;4903.632227582928;5037.672551284155;5074.949250507485;5087.847364579068;5110.488951104897;4751;4770.522947705236;4773.689710168828;4803.591694705954;4805.6155507559315;5994.501374656336;6080.513558915321;6136.846578835521;6143.354947730513;6159.568830181889;5961.910571341434;6050.3647117052515;6094.268687757498;6107.328193898667;6120.540959428016;6450.935490645081;6542.691461707677;6714.194296684429;6726.865462690719;6741.831454213684;5371.731413429313;5392.299001129867;5410.837674869721;5417.729113544347;5434.728263586844;6719.496037797136;6747.561408508481;6900.723971041152;6916.619585922772;6918.993491887347;5532.944670553243;5558.638688485235;5592;5601.80393686219;5616.691081990448;5610.382857885629;5629.605927585111;5645.689487078168;5672.744726487235;5693.658380497183;5959.374265702038;6019.909701354483;6028.849278768066;6049.425304596057;6080.422359875804;6635.203775546869;6672.199336079701;6683.832904177434;6727.360900714424;6776;1919.9136038878005;1924.6150769846088;1930.1314408516223;1931.9034048297528;1945.319138301583;1420.453125546672;1484.9655971319362;1486.5877416454196;1498.7901693762883;1501.6546194375355;5992.730327135289;6095.35998720128;6120.072177264147;6157.045657922939;6193.318734939153;6623.4701223901975;6628.5691430056895;6629.7348106075215;6716.865662686719;6722.361375669304;5987.970060149672;6076.4531192192035;6099.3900609938655;6110.388961103854;6147.508199344042;3427.3488037272837;3437.2438063625964;3498.2653642734804;3510.684038436502;3524.3832329342777;6979;7024.578525288499;7032.3670869620955;7057.576545407189;7060.6116663584;6791.796246112624;6799.252082270947;6801.4558835293055;6825.215100263434;6837.453003759687;7015.263397343206;7029.121359830021;7034.8944765828555;7036.296370362923;7045.89431158533;6528.902066469102;6621.337866213533;6637.502187335873;6652.7006284716335;6694.355729486922;6630.370114839083;6653.434458071119;6669.0996715444735;6675.963831031582;6691.832704182434;6992.755253566101;6999.650017499002;7015.859682806417;7051.294870512907;7052.435805135474;5454.236406902957;5466.72666366688;5467.289252397163;5474.233607294902;5496.148097044965;6496.837579060561;6726.9573216151575;6737.157855268091;6746.291639377795;6789.524733268624;6360.332165122781;6457.192850893638;6467.126937863328;6507.479401647952;6557.1147895035465;6403.743850245938;6474.1583594134345;6495.9025614614875;6504.252011018793;6534.346565343428;6310.267299525356;6378.553501255054;6419.422251997343;6441.484681225585;6444.806655800334;6527.281998980204;6576.539642224999;6602.537822352389;6613.834654133685;6638.668066596748;6418.807435776934;6434.420902118832;6440.8389790255615;6451.54839161273;6458 03:38:00 INFO - PID 3858 | |5;yui.html;972.1639390124487;999.8250306196413;1000.2148313573845;1010.6917390195991;1028.5680014393956;19829;20293.695594566074;20308.39074827754;20308.59382812343;20318.390448286536;18146.637067258645;18244;18347.174377153027;18661;18831.435056948278;1024;1045.6862941117672;1045.947702614866;1045.984310235347;1047.0942634621035;1056.10758908722;1060.6870973062964;1070.2026989892502;1107.036877916214;1110.4225802582653;1144.204777679513;1147.3861484105964;1148.827675848621;1148.9712757181053;1149.2989276541302;1089.84742136101;1130.8247221680654;1135.642272684102;1138.1179585820971;1144.5936692474177;814.7840822182127;816.6855760532178;816.8978877640295;817.0562999735315;818.3453237410108;20494;20624.27815026467;20665.380038598865;20669.89665051665;20701;22176.556468870695;22359.44101397478;22543.323700289016;22556.32331030072;22574.097036118535;17083.145842707938;17449.738253926073;17660.735088973677;17666.381676641256;17669.293228270853;3970.463987361727;3980.44273801668;3994.3609022556543;4002.959970400288;4015.31739604268;154495;158248;158649;158660;158902.99999999884;17235;17337.479875603753;17383.47849564515;17633.7354939676;17896.105194740212;31239;33060;33155;33431;33467.49798753021;8644.308455323559;8722.215000649972;8749.47503149813;8757.518336491426;8768.07935166811;4152.854650087293;4230.280852255124;4236.661067114624;4237.470316210473;4238.724482908601;5820.126980952807;5866.2373891393845;5919.6152250103605;5924.7926322578505;5956.315023772235;1056.5192837259028;1072.008392237193;1082.6102603063048;1085.5060947268973;1087.8368244763349;745.4930647159983;764.7170546897684;766.8696321625337;767.7351313796731;783.060327606874;12161.391930403444;12546.623601291976;12636.431360588796;12836.422360993778;12898.548550800864;688.1260798785514;704.5631708340759;714.3499415531945;717.7882524655239;727.1020289941918;4919.434265059493;4969.478204788517;5007.899842003212;5040.873978150502;5060.367454068241;145262;145677;147284;148237.2588137074;149339;99475.50262248643;100019;120077;131976.3401182988;135488.32255838657;110142.44928775466;110324.4483777576;110516;110736;112702;13228.735425291632;13416.463341466622;13536.932315338754;13622.742528368291;13891.861081389057;50120.74939625279;51003.74498127485;52767.472325276256;53817.73091134519;55774.44225557693;71088.21957226703;71263.64368178333;71659;72184.9172262427;72442;19613.509662257988;19642.214311427382;19741.70387444218;19743.80256197477;19756.20975161035;21880;21959.67060494062;22001.779982200613;22029.118835246412;22227.777722223218;19149;19158.71261931044;19289.324873629357;19344.41966741;19420;17713.202905869526;17746.29014839392;17749.467515974542;17994.100294984935;18000.189991450156;16470.75293870617;17041.403550876155;17508.47474575765;17931.282748689908;17956.820431795513;14876.851231487546;14944.701105977601;15091.622709431913;15101.848981510044;15141;14215.289235538388;14319.35562899693;14418.855811441752;14426.927865361025;14458.783118253024 03:38:00 INFO - PID 3858 | __end_tp_report 03:38:00 INFO - PID 3858 | __start_cc_report 03:38:00 INFO - PID 3858 | _x_x_mozilla_cycle_collect,347 03:38:00 INFO - PID 3858 | __end_cc_report 03:38:00 INFO - PID 3858 | __startTimestamp1505558280463__endTimestamp 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | ------- Summary: start ------- 03:38:00 INFO - PID 3858 | Number of tests: 6 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#0] dojo.html Cycles:165 Average:6244.52 Median:6458.71 stddev:884.43 (13.7%) stddev-sans-first:866.58 03:38:00 INFO - PID 3858 | Values: 3827.4 3852.3 3860.7 3863.2 3895.2 6234.7 6332.1 6355.3 6362.6 6364.8 6220.5 6328.5 6329.4 6336.6 6348.3 5559.3 5560.7 5576.3 5609.0 5666.2 5619.1 5685.9 5692.9 5704.2 5714.9 582.8 5536.0 5544.3 5617.2 5647.9 5470.9 5558.6 5629.6 5633.5 5637.3 5392.9 5457.6 5476.3 5488.3 5539.0 6234.6 6250.9 6281.7 6298.7 6337.7 6782.6 6794.9 6866.8 6869.1 6880.5 6744.5 6797.1 6871.1 6880.7 6886.8 6304.8 6309.2 6340.1 6353.5 6390.3 7056.2 7109.9 7118.3 7130.9 7133.9 6738.5 6741.5 6809.9 6820.1 6822.7 6663.2 6793.4 6843.5 6864.4 6944.6 6658.0 6778.0 6789.4 6795.7 6803.1 6742.0 6777.0 6849.4 6849.9 6856.2 4896.8 4922.0 4934.7 4971.8 4978.1 4511.1 4516.3 4529.3 4540.0 4543.3 6305.1 6337.2 6415.8 6416.8 6424.6 6731.3 6805.5 6821.3 6861.2 6929.2 6276.3 6298.7 6332.6 6333.5 6333.9 5536.6 5549.5 5568.6 5572.8 5575.6 6982.6 7093.8 7178.2 7195.0 7215.3 6664.2 6731.9 6754.5 6827.7 6846.1 7099.4 7183.9 7209.1 7224.0 7230.8 6737.5 6737.6 6813.7 6822.6 6838.4 6851.8 6867.6 6951.1 6957.4 6960.1 6503.9 6563.1 6573.1 6596.2 6663.3 6494.6 6536.0 6545.0 6548.0 6565.5 6356.4 6367.0 6426.8 6450.4 6453.3 6649.2 6692.1 6712.6 6720.7 6730.6 6422.4 6438.4 6458.7 6526.6 6530.2 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#1] ext.html Cycles:180 Average:43310.64 Median:38819.62 stddev:65817.20 (169.5%) stddev-sans-first:65924.91 03:38:00 INFO - PID 3858 | Values: 932.2 956.9 973.3 986.6 989.9 43295.4 44180.3 44815.6 44897.8 45155.8 42185.8 42417.8 42494.0 42517.6 42579.8 7492.7 7579.8 7588.1 7614.8 7620.2 7366.9 7454.7 7458.1 7465.6 7465.8 7444.9 7924.0 8018.4 8036.6 8036.9 7938.3 7988.1 7992.7 7992.9 8001.1 7684.0 7774.7 7781.8 7795.6 7963.2 42101.8 42448.6 42567.8 42600.4 42616.6 3690.2 3738.9 3739.5 3739.6 3742.6 34339.0 34424.8 34494.1 34503.8 34534.8 5524.5 5534.7 5562.6 5568.1 5617.5 204880.0 208227.0 215696.0 219271.0 263178.0 52228.2 52953.2 53021.7 53457.7 53534.0 55366.4 55602.0 55663.7 55668.4 55944.7 14750.3 14776.3 14791.3 14847.8 14957.9 11796.6 11898.8 11932.3 11941.8 11948.5 14388.6 14590.2 14599.3 14760.0 14831.3 5919.9 6095.2 6102.0 6115.6 6137.7 1086.5 1093.9 1106.8 1111.7 1142.2 25074.6 25290.5 25310.9 25411.0 25468.6 1172.6 1179.5 1180.4 1180.7 1194.9 13195.1 13428.9 13462.1 13502.7 13561.5 286149.0 288095.0 290112.0 292998.0 293901.0 55705.4 56267.2 59925.7 60761.0 61028.4 1440.4 1470.8 1472.0 1472.7 1500.1 29132.9 29468.0 30027.0 30062.4 30594.4 40284.6 40717.2 40813.0 40847.0 40930.6 238436.0 239229.0 240100.0 240913.0 241927.0 38161.2 39478.0 39686.8 39883.0 40219.4 48141.3 49561.8 49706.0 49879.5 50014.0 35950.5 36268.8 36396.0 36414.6 36573.6 36273.5 36396.3 36426.5 36491.8 36626.6 42069.0 42188.0 42225.4 42418.6 42522.6 34769.5 34880.0 35218.1 35238.3 35241.0 26534.3 26685.3 26740.9 26781.0 27096.2 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#2] jquery.html Cycles:180 Average:39060.16 Median:22083.11 stddev:100289.13 (454.1%) stddev-sans-first:100528.86 03:38:00 INFO - PID 3858 | Values: 584.0 584.2 586.9 601.6 602.8 22845.4 23688.3 23762.6 23764.8 23790.0 24208.6 24869.3 26123.6 26275.9 26302.0 6687.9 6868.8 6870.5 6871.0 6897.1 6412.0 6705.2 6737.6 6781.8 6822.4 6593.5 6600.6 6658.4 6659.5 6659.5 6661.3 6662.2 6667.1 6668.3 6669.0 6169.9 6370.4 6370.8 6373.1 6393.7 29864.7 30229.5 30355.5 30447.7 30553.1 2160.2 2182.8 2182.9 2183.5 2192.0 20954.9 21100.8 21479.1 21773.2 22017.1 2444.8 2451.9 2502.0 2513.8 2540.6 132263.0 138640.9 139390.0 144488.0 151158.0 15608.8 16184.3 16220.4 16251.8 16559.6 24978.0 25006.0 25014.4 25041.1 25102.7 10128.2 10130.6 10162.7 10339.9 10351.9 9245.4 9276.2 9307.2 9314.3 9340.6 9718.5 9776.8 9894.6 10067.8 10192.6 2902.9 2939.9 2962.3 2974.6 3046.1 1021.0 1051.8 1056.8 1060.9 1081.7 21763.0 21859.8 21963.6 22039.8 22126.4 1091.3 1101.2 1101.4 1102.3 1112.9 11907.7 12001.6 12099.4 12144.9 12237.7 575139.0 577108.0 590888.0 629882.0 633801.0 122026.0 123256.0 125964.0 126666.0 128935.0 1211.4 1217.5 1246.2 1247.1 1247.7 18544.4 18726.3 19008.2 19096.5 19569.4 60803.0 60906.4 62704.4 63288.0 63351.0 73032.3 73965.0 74156.3 75990.6 76720.0 15459.8 15624.5 15650.5 15689.5 15709.0 24489.6 24780.6 24809.5 25100.2 25164.5 19725.5 19900.5 20009.0 20042.8 20350.7 17276.1 17910.4 17931.8 18028.6 18387.9 18593.1 18752.4 18765.9 18823.7 19354.9 15032.7 15107.4 15152.8 15186.1 15273.7 19120.8 19338.1 19697.0 19713.3 19721.9 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#3] mootools.html Cycles:180 Average:10374.18 Median:2687.69 stddev:7740.17 (288.0%) stddev-sans-first:7732.73 03:38:00 INFO - PID 3858 | Values: 1431.5 1483.7 1500.7 1510.5 1523.7 16606.3 17112.4 17260.4 17274.9 17283.8 16829.6 16882.7 16918.2 16951.5 16960.7 2867.7 2884.0 2904.4 2904.5 2929.4 2841.2 2875.7 2880.8 2882.2 2883.4 2458.6 2643.1 2665.6 2668.4 2673.1 2863.3 2899.2 2902.7 2919.1 2935.4 2626.9 2702.3 2707.7 2712.1 2724.7 16730.2 16858.2 16870.7 16881.9 16903.2 8648.1 8947.4 8969.7 8971.7 8975.7 5692.0 5741.4 5812.8 5865.9 5897.6 2091.3 2125.2 2126.3 2130.4 2145.6 30379.4 30679.0 30715.5 30762.0 30928.1 7342.8 7390.2 7430.9 7505.5 7525.9 19118.2 19291.0 19372.2 19374.3 19386.3 8192.1 8375.6 8422.2 8454.2 8455.0 7498.3 7573.5 7696.5 7697.1 7803.8 5660.8 5789.0 5790.2 5836.8 5938.3 1682.5 1691.8 1700.5 1701.2 1730.6 926.1 945.0 946.8 956.3 965.8 8330.5 8346.4 8351.9 8482.5 8494.6 754.2 780.8 784.9 797.8 807.2 5085.8 5158.0 5526.5 5719.3 6027.2 23533.2 24687.4 25016.6 25344.9 25421.5 24723.0 24744.8 25175.4 25437.6 25680.7 12331.5 12492.3 12645.2 12753.2 12761.6 8858.5 8887.5 8979.1 8987.5 9133.7 20811.4 21477.2 21593.2 21610.5 21747.3 21491.5 21750.6 21808.7 21959.8 22173.8 12327.9 12500.2 12519.2 12522.9 12538.1 15570.5 15978.4 16047.7 16053.8 16072.8 11838.6 11885.5 11901.5 12161.0 12321.0 11695.9 11734.8 11965.8 12029.2 12207.1 10331.5 10385.9 10565.7 10566.4 10571.5 7707.9 8084.8 8085.9 8090.9 8112.9 7849.0 8001.8 8024.8 8043.9 8087.6 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#4] prototype.html Cycles:180 Average:5678.28 Median:6198.81 stddev:1533.16 (24.7%) stddev-sans-first:1487.74 03:38:00 INFO - PID 3858 | Values: 518.5 546.2 556.7 564.6 576.3 6196.8 6218.5 6240.2 6255.5 6303.1 6200.9 6248.2 6253.4 6277.4 6286.0 4917.7 5019.5 5030.4 5050.4 5077.7 4995.2 5059.5 5062.4 5075.8 5099.4 4946.3 4953.8 4968.7 4978.9 4993.7 4903.6 5037.7 5074.9 5087.8 5110.5 4751.0 4770.5 4773.7 4803.6 4805.6 5994.5 6080.5 6136.8 6143.4 6159.6 5961.9 6050.4 6094.3 6107.3 6120.5 6450.9 6542.7 6714.2 6726.9 6741.8 5371.7 5392.3 5410.8 5417.7 5434.7 6719.5 6747.6 6900.7 6916.6 6919.0 5532.9 5558.6 5592.0 5601.8 5616.7 5610.4 5629.6 5645.7 5672.7 5693.7 5959.4 6019.9 6028.8 6049.4 6080.4 6635.2 6672.2 6683.8 6727.4 6776.0 1919.9 1924.6 1930.1 1931.9 1945.3 1420.5 1485.0 1486.6 1498.8 1501.7 5992.7 6095.4 6120.1 6157.0 6193.3 6623.5 6628.6 6629.7 6716.9 6722.4 5988.0 6076.5 6099.4 6110.4 6147.5 3427.3 3437.2 3498.3 3510.7 3524.4 6979.0 7024.6 7032.4 7057.6 7060.6 6791.8 6799.3 6801.5 6825.2 6837.5 7015.3 7029.1 7034.9 7036.3 7045.9 6528.9 6621.3 6637.5 6652.7 6694.4 6630.4 6653.4 6669.1 6676.0 6691.8 6992.8 6999.7 7015.9 7051.3 7052.4 5454.2 5466.7 5467.3 5474.2 5496.1 6496.8 6727.0 6737.2 6746.3 6789.5 6360.3 6457.2 6467.1 6507.5 6557.1 6403.7 6474.2 6495.9 6504.3 6534.3 6310.3 6378.6 6419.4 6441.5 6444.8 6527.3 6576.5 6602.5 6613.8 6638.7 6418.8 6434.4 6440.8 6451.5 6458.0 03:38:00 INFO - PID 3858 | 03:38:00 INFO - PID 3858 | [#5] yui.html Cycles:180 Average:27656.84 Median:18746.22 stddev:40752.05 (217.4%) stddev-sans-first:40817.12 03:38:00 INFO - PID 3858 | Values: 972.2 999.8 1000.2 1010.7 1028.6 19829.0 20293.7 20308.4 20308.6 20318.4 18146.6 18244.0 18347.2 18661.0 18831.4 1024.0 1045.7 1045.9 1046.0 1047.1 1056.1 1060.7 1070.2 1107.0 1110.4 1144.2 1147.4 1148.8 1149.0 1149.3 1089.8 1130.8 1135.6 1138.1 1144.6 814.8 816.7 816.9 817.1 818.3 20494.0 20624.3 20665.4 20669.9 20701.0 22176.6 22359.4 22543.3 22556.3 22574.1 17083.1 17449.7 17660.7 17666.4 17669.3 3970.5 3980.4 3994.4 4003.0 4015.3 154495.0 158248.0 158649.0 158660.0 158903.0 17235.0 17337.5 17383.5 17633.7 17896.1 31239.0 33060.0 33155.0 33431.0 33467.5 8644.3 8722.2 8749.5 8757.5 8768.1 4152.9 4230.3 4236.7 4237.5 4238.7 5820.1 5866.2 5919.6 5924.8 5956.3 1056.5 1072.0 1082.6 1085.5 1087.8 745.5 764.7 766.9 767.7 783.1 12161.4 12546.6 12636.4 12836.4 12898.5 688.1 704.6 714.3 717.8 727.1 4919.4 4969.5 5007.9 5040.9 5060.4 145262.0 145677.0 147284.0 148237.3 149339.0 99475.5 100019.0 120077.0 131976.3 135488.3 110142.4 110324.4 110516.0 110736.0 112702.0 13228.7 13416.5 13536.9 13622.7 13891.9 50120.7 51003.7 52767.5 53817.7 55774.4 71088.2 71263.6 71659.0 72184.9 72442.0 19613.5 19642.2 19741.7 19743.8 19756.2 21880.0 21959.7 22001.8 22029.1 22227.8 19149.0 19158.7 19289.3 19344.4 19420.0 17713.2 17746.3 17749.5 17994.1 18000.2 16470.8 17041.4 17508.5 17931.3 17956.8 14876.9 14944.7 15091.6 15101.8 15141.0 14215.3 14319.4 14418.9 14426.9 14458.8 03:38:00 INFO - PID 3858 | -------- Summary: end -------- 03:38:00 INFO - PID 3858 | 03:38:01 INFO - TEST-INFO | 3858: exit 0 03:38:01 INFO - TEST-OK | dromaeo_css | took 1112330ms 03:38:01 INFO - TEST-START | kraken 03:38:01 INFO - Initialising browser for kraken test... 03:38:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33056/getInfo.html -profile /tmp/tmpveEWf7/profile 03:38:01 INFO - TEST-INFO | started process 4227 (/builds/slave/test/build/application/firefox/firefox http://localhost:33056/getInfo.html) 03:38:06 INFO - TEST-INFO | 4227: exit 0 03:38:06 INFO - Browser initialized. 03:38:06 INFO - Running cycle 1/1 for kraken test... 03:38:06 INFO - Using env: {'DISPLAY': ':0', 03:38:06 INFO - 'HOME': '/home/cltbld', 03:38:06 INFO - 'JSGC_DISABLE_POISONING': '1', 03:38:06 INFO - 'LANG': 'en_US.UTF-8', 03:38:06 INFO - 'LANGUAGE': 'en_US:en', 03:38:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:38:06 INFO - 'LOGNAME': 'cltbld', 03:38:06 INFO - 'MAIL': '/var/mail/cltbld', 03:38:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:06 INFO - 'MOZ_CRASHREPORTER': '1', 03:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:38:06 INFO - 'MOZ_NO_REMOTE': '1', 03:38:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:06 INFO - 'NO_EM_RESTART': '1', 03:38:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:06 INFO - 'PWD': '/builds/slave/test', 03:38:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:06 INFO - 'RUST_BACKTRACE': 'full', 03:38:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:38:06 INFO - 'SHELL': '/bin/bash', 03:38:06 INFO - 'SHLVL': '1', 03:38:06 INFO - 'TERM': 'linux', 03:38:06 INFO - 'TMOUT': '86400', 03:38:06 INFO - 'USER': 'cltbld', 03:38:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632', 03:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:06 INFO - '_': '/tools/buildbot/bin/python'} 03:38:06 INFO - TEST-INFO | started process 4463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpveEWf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:07 INFO - PID 4463 | 03:38:07 INFO - PID 4463 | (/builds/slave/test/build/application/firefox/firefox:4513): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:07 INFO - PID 4463 | 03:38:17 INFO - PID 4463 | RSS: Main: 166969344 03:38:17 INFO - PID 4463 | 03:38:20 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33056/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:21 INFO - PID 4463 | RSS: Main: 173219840 03:38:21 INFO - PID 4463 | 03:38:23 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33056/tests/kraken/driver.html?testName=audio-dft) 03:38:24 INFO - PID 4463 | RSS: Main: 173060096 03:38:24 INFO - PID 4463 | 03:38:27 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33056/tests/kraken/driver.html?testName=audio-fft) 03:38:28 INFO - PID 4463 | RSS: Main: 167792640 03:38:28 INFO - PID 4463 | 03:38:30 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33056/tests/kraken/driver.html?testName=audio-oscillator) 03:38:30 INFO - PID 4463 | RSS: Main: 168411136 03:38:30 INFO - PID 4463 | 03:38:32 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33056/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:33 INFO - PID 4463 | RSS: Main: 168718336 03:38:33 INFO - PID 4463 | 03:38:36 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33056/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:37 INFO - PID 4463 | RSS: Main: 172068864 03:38:37 INFO - PID 4463 | 03:38:40 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33056/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:41 INFO - PID 4463 | RSS: Main: 171483136 03:38:41 INFO - PID 4463 | 03:38:44 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33056/tests/kraken/driver.html?testName=json-parse-financial) 03:38:44 INFO - PID 4463 | RSS: Main: 171331584 03:38:44 INFO - PID 4463 | 03:38:46 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33056/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:47 INFO - PID 4463 | RSS: Main: 171175936 03:38:47 INFO - PID 4463 | 03:38:48 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:49 INFO - PID 4463 | RSS: Main: 171446272 03:38:49 INFO - PID 4463 | 03:38:51 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:52 INFO - PID 4463 | RSS: Main: 168521728 03:38:52 INFO - PID 4463 | 03:38:54 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:55 INFO - PID 4463 | RSS: Main: 168321024 03:38:55 INFO - PID 4463 | 03:38:57 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:58 INFO - PID 4463 | RSS: Main: 168562688 03:38:58 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | Cycle 1(1): loaded http://localhost:33056/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33056/tests/kraken/driver.html?testName=ai-astar) 03:39:00 INFO - PID 4463 | RSS: Main: 170819584 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | __start_tp_report 03:39:00 INFO - PID 4463 | _x_x_mozilla_page_load 03:39:00 INFO - PID 4463 | _x_x_mozilla_page_load_details 03:39:00 INFO - PID 4463 | |i|pagename|runs| 03:39:00 INFO - PID 4463 | |0;ai-astar;106;107;106;104;106;106;107;106;106;106 03:39:00 INFO - PID 4463 | |1;audio-beat-detection;114;114;116;113;111;112;115;115;112;113 03:39:00 INFO - PID 4463 | |2;audio-dft;162;162;162;162;163;163;161;164;168;166 03:39:00 INFO - PID 4463 | |3;audio-fft;75;74;73;73;73;72;74;73;74;73 03:39:00 INFO - PID 4463 | |4;audio-oscillator;80;79;77;78;77;83;78;78;79;77 03:39:00 INFO - PID 4463 | |5;imaging-gaussian-blur;114;114;113;113;116;116;116;114;114;114 03:39:00 INFO - PID 4463 | |6;imaging-darkroom;159;151;149;149;149;149;150;151;151;149 03:39:00 INFO - PID 4463 | |7;imaging-desaturate;94;94;93;93;94;94;95;93;94;94 03:39:00 INFO - PID 4463 | |8;json-parse-financial;46;45;45;45;47;45;46;47;44;45 03:39:00 INFO - PID 4463 | |9;json-stringify-tinderbox;39;39;38;38;39;39;39;39;39;38 03:39:00 INFO - PID 4463 | |10;stanford-crypto-aes;71;74;71;72;73;71;73;76;72;73 03:39:00 INFO - PID 4463 | |11;stanford-crypto-ccm;109;102;103;111;106;103;114;103;106;104 03:39:00 INFO - PID 4463 | |12;stanford-crypto-pbkdf2;149;152;155;158;154;155;156;151;154;156 03:39:00 INFO - PID 4463 | |13;stanford-crypto-sha256-iterative;64;65;61;59;59;59;59;60;60;62 03:39:00 INFO - PID 4463 | __end_tp_report 03:39:00 INFO - PID 4463 | __start_cc_report 03:39:00 INFO - PID 4463 | _x_x_mozilla_cycle_collect,907 03:39:00 INFO - PID 4463 | __end_cc_report 03:39:00 INFO - PID 4463 | __startTimestamp1505558340420__endTimestamp 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | ------- Summary: start ------- 03:39:00 INFO - PID 4463 | Number of tests: 14 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 03:39:00 INFO - PID 4463 | Values: 106.0 107.0 106.0 104.0 106.0 106.0 107.0 106.0 106.0 106.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#1] audio-beat-detection Cycles:10 Average:113.50 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 03:39:00 INFO - PID 4463 | Values: 114.0 114.0 116.0 113.0 111.0 112.0 115.0 115.0 112.0 113.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.16 (1.3%) stddev-sans-first:2.24 03:39:00 INFO - PID 4463 | Values: 162.0 162.0 162.0 162.0 163.0 163.0 161.0 164.0 168.0 166.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:0.84 (1.1%) stddev-sans-first:0.67 03:39:00 INFO - PID 4463 | Values: 75.0 74.0 73.0 73.0 73.0 72.0 74.0 73.0 74.0 73.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.50 stddev:1.84 (2.3%) stddev-sans-first:1.88 03:39:00 INFO - PID 4463 | Values: 80.0 79.0 77.0 78.0 77.0 83.0 78.0 78.0 79.0 77.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.17 (1.0%) stddev-sans-first:1.24 03:39:00 INFO - PID 4463 | Values: 114.0 114.0 113.0 113.0 116.0 116.0 116.0 114.0 114.0 114.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.50 stddev:3.06 (2.0%) stddev-sans-first:0.97 03:39:00 INFO - PID 4463 | Values: 159.0 151.0 149.0 149.0 149.0 149.0 150.0 151.0 151.0 149.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:39:00 INFO - PID 4463 | Values: 94.0 94.0 93.0 93.0 94.0 94.0 95.0 93.0 94.0 94.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:45.50 stddev:0.97 (2.1%) stddev-sans-first:1.01 03:39:00 INFO - PID 4463 | Values: 46.0 45.0 45.0 45.0 47.0 45.0 46.0 47.0 44.0 45.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.48 (1.2%) stddev-sans-first:0.50 03:39:00 INFO - PID 4463 | Values: 39.0 39.0 38.0 38.0 39.0 39.0 39.0 39.0 39.0 38.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:1.58 (2.2%) stddev-sans-first:1.56 03:39:00 INFO - PID 4463 | Values: 71.0 74.0 71.0 72.0 73.0 71.0 73.0 76.0 72.0 73.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#11] stanford-crypto-ccm Cycles:10 Average:106.10 Median:106.00 stddev:4.01 (3.8%) stddev-sans-first:4.12 03:39:00 INFO - PID 4463 | Values: 109.0 102.0 103.0 111.0 106.0 103.0 114.0 103.0 106.0 104.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:155.00 stddev:2.67 (1.7%) stddev-sans-first:2.13 03:39:00 INFO - PID 4463 | Values: 149.0 152.0 155.0 158.0 154.0 155.0 156.0 151.0 154.0 156.0 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:60.50 stddev:2.20 (3.6%) stddev-sans-first:2.01 03:39:00 INFO - PID 4463 | Values: 64.0 65.0 61.0 59.0 59.0 59.0 59.0 60.0 60.0 62.0 03:39:00 INFO - PID 4463 | -------- Summary: end -------- 03:39:00 INFO - PID 4463 | 03:39:00 INFO - PID 4463 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:39:01 INFO - TEST-INFO | 4463: exit 0 03:39:01 INFO - TEST-OK | kraken | took 59997ms 03:39:01 INFO - SUITE-END | took 1172s 03:39:01 INFO - Completed test suite (00:19:32) 03:39:01 INFO - javascript benchmark 03:39:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9038.169763833745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3827.425886117082, 3852.268069066877, 3860.671842893355, 3863.227354529093, 3895.240428116515, 6234.719437625306, 6332.081848132029, 6355.269144048436, 6362.58643188193, 6364.777232796847, 6220.533459990496, 6328.493720502361, 6329.430351268385, 6336.588121772082, 6348.333424990367, 5559.305086864142, 5560.666360018392, 5576.33084029915, 5609.046462101453, 5666.178404131399, 5619.129034999562, 5685.857853553653, 5692.8861422771515, 5704.172894930232, 5714.857128571798, 582.8453636270968, 5536.031194540939, 5544.251526043993, 5617.157426386034, 5647.915281270784, 5470.890582188374, 5558.555315574744, 5629.577781666391, 5633.492985631272, 5637.267155269829, 5392.91910621341, 5457.617966742329, 5476.26070480484, 5488.313960754906, 5539.002979463695, 6234.625922444668, 6250.9062364064575, 6281.748730050793, 6298.748050077991, 6337.683115844189, 6782.559133656297, 6794.864102717967, 6866.828329291758, 6869.072675188835, 6880.483963702743, 6744.494162937799, 6797.116374871284, 6871.072405225281, 6880.65596720162, 6886.758963436256, 6304.810855674337, 6309.179806625155, 6340.112384266206, 6353.523485738542, 6390.297067322591, 7056.2238153803555, 7109.92890071103, 7118.323759242864, 7130.857382852314, 7133.894246391817, 6738.494612904052, 6741.460683145337, 6809.863802723918, 6820.079289295882, 6822.692978815965, 6663.233728121231, 6793.354631310018, 6843.486738494633, 6864.38220560142, 6944.583325000516, 6658.03458498515, 6778.017187507784, 6789.388954994074, 6795.72817087311, 6803.115594972622, 6741.966290168518, 6777.0, 6849.417799487, 6849.897251541231, 6856.177258728984, 4896.779644915988, 4921.975390123026, 4934.703917764946, 4971.825986090469, 4978.079055374767, 4511.120331535385, 4516.254817955, 4529.252673308867, 4539.977300113478, 4543.295789152687, 6305.117283580303, 6337.207849018872, 6415.839604009937, 6416.839579010469, 6424.646644434601, 6731.32686731323, 6805.4895882808, 6821.283765204582, 6861.245263021064, 6929.1684997799575, 6276.278228003746, 6298.7480500780375, 6332.556721029576, 6333.493320534346, 6333.8733225336155, 5536.612437129443, 5549.528290095306, 5568.554515638739, 5572.777088916479, 5575.553955683536, 6982.61595612236, 7093.822654433578, 7178.17450993132, 7195.0, 7215.314545118205, 6664.233613134552, 6731.899021514779, 6754.493412994045, 6827.658617069027, 6846.144231971004, 7099.43204543625, 7183.8563228736175, 7209.134903811367, 7224.0, 7230.783076507713, 6737.461003119836, 6737.562058466184, 6813.693383797642, 6822.590644561342, 6838.350356716104, 6851.835188017949, 6867.587944723133, 6951.061606683235, 6957.443404527525, 6960.129983752031, 6503.902441463477, 6563.113979612882, 6573.079768832272, 6596.175478065242, 6663.300353462817, 6494.577852439576, 6535.967320163369, 6545.0, 6547.9672601638595, 6565.540412171103, 6356.396142366468, 6366.9681651591445, 6426.843168229763, 6450.419462248233, 6453.290138084713, 6649.202095748541, 6692.063111164343, 6712.597244165366, 6720.731170753115, 6730.629815360202, 6422.3577642235405, 6438.356164383524, 6458.709358078804, 6526.575772574957, 6530.216374035146], "value": 6184.257935488578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [932.1750251027843, 956.8947415784264, 973.3040875773822, 986.5609803637384, 989.8812142542891, 43295.35056974148, 44180.337294940604, 44815.551844481546, 44897.77551112248, 45155.77422112893, 42185.78907105468, 42417.78791106048, 42494.0, 42517.57482425175, 42579.78710106453, 7492.700291988314, 7579.81050473737, 7588.089429268468, 7614.809629759245, 7620.161782203953, 7366.931794889738, 7454.664540095681, 7458.10502739672, 7465.589392583406, 7465.813354666149, 7444.925550744478, 7923.96038019812, 8018.398620103487, 8036.598170091501, 8036.879446808302, 7938.325242354407, 7988.121306656263, 7992.720254791113, 7992.880106798402, 8001.079875814268, 7683.961580192064, 7774.65014074368, 7781.844363112763, 7795.61021948906, 7963.1638677939145, 42101.78949105265, 42448.575514244774, 42567.787161064, 42600.360994585106, 42616.57383426157, 3690.2066055797864, 3738.9439158412647, 3739.476473293741, 3739.5886452490204, 3742.5696044954907, 34339.0, 34424.82787586071, 34494.13764655879, 34503.82748086269, 34534.82732586321, 5524.475174858382, 5534.723263836832, 5562.638428502134, 5568.081266591008, 5617.494425501724, 204880.0, 208227.0, 215696.0, 219271.0, 263177.9999999981, 52228.21657675138, 52953.2057019145, 53021.73489132529, 53457.732711336976, 53534.0, 55366.44633553613, 55602.0, 55663.72168139214, 55668.443315567136, 55944.72027639836, 14750.336234869243, 14776.335064922105, 14791.260436978107, 14847.777283340758, 14957.925210373878, 11796.646100616996, 11898.762024759457, 11932.28406295625, 11941.761164776655, 11948.522059117711, 14388.640283992774, 14590.197539135237, 14599.270036498132, 14760.0, 14831.258437078102, 5919.881602368015, 6095.177151084636, 6102.0, 6115.602485838406, 6137.662428566472, 1086.5219303506433, 1093.8796732359592, 1106.7620461600795, 1111.7331840358256, 1142.2061667141422, 25074.623880641804, 25290.494190116096, 25310.873445632653, 25411.0, 25468.617970730083, 1172.6130376975577, 1179.4574495731888, 1180.397997021508, 1180.7166280092715, 1194.940252987347, 13195.110258868663, 13428.865711342956, 13462.057655964185, 13502.729945401037, 13561.525346612822, 286149.0, 288095.0, 290112.0, 292998.0, 293901.0, 55705.44294557002, 56267.15599266014, 59925.700371497864, 60761.0, 61028.38971610227, 1440.4454285100312, 1470.8161479815024, 1471.977920331196, 1472.7159726538223, 1500.0699566268984, 29132.854335729033, 29468.0, 30027.0, 30062.3987520244, 30594.388112238077, 40284.59715402926, 40717.1856562873, 40813.0, 40847.0, 40930.59069409268, 238436.0, 239229.0, 240100.0, 240913.0, 241927.0, 38161.23677526379, 39478.0, 39686.801565991984, 39883.0, 40219.39670904997, 48141.27788083111, 49561.75219123881, 49706.0, 49879.501204987486, 50014.0, 35950.460743089396, 36268.818655907606, 36396.0, 36414.63585364113, 36573.634263657026, 36273.45589816208, 36396.27207455889, 36426.4536031965, 36491.817540912125, 36626.633733662326, 42069.0, 42188.0, 42225.36661950012, 42418.57581424146, 42522.57477425186, 34769.47845782366, 34880.0, 35218.11954701153, 35238.29523409569, 35241.0, 26534.336641584116, 26685.332866678487, 26740.8662956684, 26781.0, 27096.1871143866], "value": 18626.659728347822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9678817665027, 584.2346526050876, 586.9119632055194, 601.5638661970071, 602.8492876780804, 22845.4288642784, 23688.289351319465, 23762.64356034661, 23764.76235237647, 23790.0, 24208.636870446957, 24869.25392238231, 26123.608145877828, 26275.86862065687, 26302.0, 6687.933120668779, 6868.793936181897, 6870.519063665545, 6871.0, 6897.068895699092, 6412.0, 6705.228898676642, 6737.629430381327, 6781.830454238659, 6822.351876571743, 6593.505487088463, 6600.570962887421, 6658.434033107192, 6659.467242620579, 6659.467242620579, 6661.26726060133, 6662.233843108056, 6667.066610674485, 6668.266490686045, 6668.9666551667415, 6169.876602467925, 6370.362963703639, 6370.840728981812, 6373.075903993895, 6393.712282947232, 29864.701352986627, 30229.546556801666, 30355.544666830014, 30447.69552304471, 30553.083407497812, 2160.179131929857, 2182.8362872784605, 2182.890855457221, 2183.4977955070262, 2191.9561608767895, 20954.895225523927, 21100.788992110036, 21479.140834366608, 21773.2379366723, 22017.11931522737, 2444.767747064026, 2451.8651474168914, 2502.0, 2513.7988960883085, 2540.5681034224226, 132263.0, 138640.92038619428, 139390.0, 144488.0, 151158.0, 15608.765868511982, 16184.271707773178, 16220.351185952666, 16251.756223656655, 16559.586010349598, 24978.0, 25006.0, 25014.37464063413, 25041.12356067529, 25102.748972510406, 10128.240381971382, 10130.645427410152, 10162.695119146438, 10339.914308997448, 10351.861295257515, 9245.399049061789, 9276.16514513697, 9307.208887244524, 9314.301427392973, 9340.626374945063, 9718.465484398284, 9776.804463910825, 9894.55474503649, 10067.848982265272, 10192.643257485952, 2902.9274268143467, 2939.853007349624, 2962.303858593229, 2974.598429212072, 3046.055722725962, 1020.9642662506776, 1051.7791263834526, 1056.8361903904906, 1060.8514807926897, 1081.7457897394106, 21763.0, 21859.781402186094, 21963.560728785335, 22039.779602203773, 22126.446838828837, 1091.317926296065, 1101.1906248907046, 1101.3777215873006, 1102.2669924500278, 1112.933224006562, 11907.702307442383, 12001.63995080149, 12099.395030248452, 12144.878551214375, 12237.694057648452, 575139.0, 577108.0, 590888.0, 629882.0, 633801.0, 122026.0, 123256.0, 125964.0, 126666.0, 128935.0, 1211.3882489343002, 1217.4521465340456, 1246.2397937258265, 1247.0958555047519, 1247.6631309546372, 18544.443666690022, 18726.25094996185, 19008.23967041303, 19096.522586935436, 19569.412917612495, 60803.0, 60906.39093609185, 62704.37295626985, 63288.0, 63351.0, 73032.26967730255, 73965.0, 74156.2584374171, 75990.6200468994, 76720.0, 15459.845401545841, 15624.453144139901, 15650.530484085495, 15689.529314120595, 15709.0, 24489.632655510537, 24780.628290575296, 24809.503809924063, 25100.24699259025, 25164.49671006533, 19725.506862328555, 19900.50248743793, 20008.99955002215, 20042.799572004093, 20350.694739579216, 17276.13619319054, 17910.373136940143, 17931.820681793015, 18028.639427211645, 18387.908060460148, 18593.070346482353, 18752.437426877215, 18765.90617046906, 18823.71764423562, 19354.903225483784, 15032.699346013238, 15107.39570417171, 15152.772708409162, 15186.088834669956, 15273.694526109637, 19120.808791911903, 19338.129784160028, 19697.0, 19713.310034148737, 19721.901390492956], "value": 12675.715888949126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.4846655204126, 1483.7180935622232, 1500.6923580665964, 1510.5317351620995, 1523.7257293687132, 16606.25271862766, 17112.401065962695, 17260.395886143986, 17274.913625431855, 17283.82716172838, 16829.579260518494, 16882.66234675306, 16918.238679259433, 16951.49145525636, 16960.74558881618, 2867.713228677131, 2884.0, 2904.4481548505823, 2904.5207540755855, 2929.3555417808047, 2841.2044627504333, 2875.683674795771, 2880.7983441159126, 2882.221800113968, 2883.408901175254, 2458.5943319352286, 2643.074923776682, 2665.6001599759998, 2668.4129491511935, 2673.051066871262, 2863.3128049268234, 2899.173735485387, 2902.709729027091, 2919.065898912349, 2935.354222071141, 2626.8949242030294, 2702.337927207847, 2707.742764437375, 2712.118561467531, 2724.6730392353043, 16730.247138878778, 16858.24137913797, 16870.662586748196, 16881.915590422093, 16903.23935422909, 8648.09195034525, 8947.373683842134, 8969.686060987835, 8971.730848074569, 8975.685850995249, 5691.971540142315, 5741.368449470555, 5812.796552120655, 5865.912011319833, 5897.587168898179, 2091.309867743656, 2125.171183238538, 2126.26643807886, 2130.3928380411508, 2145.6030634332697, 30379.392412151854, 30679.0, 30715.539266911015, 30762.0, 30928.0721578353, 7342.77971660851, 7390.187079421259, 7430.925690743132, 7505.4746167767735, 7525.924740752523, 19118.2352705893, 19291.0, 19372.225110995685, 19374.321898733477, 19386.321478748177, 8192.098869124391, 8375.581220938928, 8422.24199822019, 8454.239118479367, 8455.0, 7498.287662672037, 7573.46985711006, 7696.461247712607, 7697.114831794303, 7803.765887023398, 5660.773569057192, 5788.971055144697, 5790.160426738099, 5836.795712150054, 5938.346781853993, 1682.528891910267, 1691.805442374118, 1700.4558541266676, 1701.2259421962976, 1730.6279149982813, 926.0924294191595, 944.9574769135405, 946.8059047895165, 956.321012081416, 965.8406362950175, 8330.458520196167, 8346.4157508975, 8351.874721879176, 8482.491050536988, 8494.575271236414, 754.2495217258862, 780.7579650308422, 784.8979632647834, 797.8284668796236, 807.2290962131268, 5085.847424577195, 5158.0, 5526.47498487643, 5719.256496655408, 6027.246594175728, 23533.17633882806, 24687.38281542976, 25016.624750628755, 25344.873275633505, 25421.49157016849, 24723.0, 24744.752552474605, 25175.37061573475, 25437.61843572311, 25680.74319256821, 12331.50673973049, 12492.250464971949, 12645.178063425848, 12753.234805911676, 12761.553345632858, 8858.46849189025, 8887.511186884783, 8979.10208979123, 8987.505687187268, 9133.680321188727, 20811.375658730263, 21477.248296309554, 21593.24423645165, 21610.459738506033, 21747.347579572637, 21491.46271343229, 21750.56498869982, 21808.672869906648, 21959.78040219641, 22173.778262217817, 12327.876721233031, 12500.249985000566, 12519.248845069325, 12522.87477125217, 12538.059645526804, 15570.532884013497, 15978.440754573534, 16047.67904641924, 16053.759193611872, 16072.758908616146, 11838.63855656576, 11885.46515406826, 11901.464434100659, 12161.0, 12320.952719018625, 11695.88304116948, 11734.823977640172, 11965.820512692142, 12029.218100823418, 12207.145499814927, 10331.483425828828, 10385.948070259601, 10565.735856603646, 10566.41884696349, 10571.5242814072, 7707.88438173439, 8084.797880052811, 8085.919140808516, 8090.87863682057, 8112.878306825521, 7849.0, 8001.759947201594, 8024.799380015313, 8043.87934180976, 8087.63605637736], "value": 7225.541164966761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.530729689631, 546.2379979927999, 556.6771272661856, 564.5596434780871, 576.2997957481659, 6196.752129914804, 6218.502519798417, 6240.15757872687, 6255.468285195758, 6303.149074874902, 6200.875982480347, 6248.18831525814, 6253.374662533744, 6277.403646653572, 6286.0, 4917.680350777188, 5019.472955339692, 5030.421501527317, 5050.393952725678, 5077.6953382797055, 4995.200767877141, 5059.519345662156, 5062.443131255559, 5075.847724568269, 5099.4390617032095, 4946.332245146895, 4953.752312384385, 4968.677035992667, 4978.850634480971, 4993.650444468889, 4903.632227582928, 5037.672551284155, 5074.949250507485, 5087.847364579068, 5110.488951104897, 4751.0, 4770.522947705236, 4773.689710168828, 4803.591694705954, 4805.6155507559315, 5994.501374656336, 6080.513558915321, 6136.846578835521, 6143.354947730513, 6159.568830181889, 5961.910571341434, 6050.3647117052515, 6094.268687757498, 6107.328193898667, 6120.540959428016, 6450.935490645081, 6542.691461707677, 6714.194296684429, 6726.865462690719, 6741.831454213684, 5371.731413429313, 5392.299001129867, 5410.837674869721, 5417.729113544347, 5434.728263586844, 6719.496037797136, 6747.561408508481, 6900.723971041152, 6916.619585922772, 6918.993491887347, 5532.944670553243, 5558.638688485235, 5592.0, 5601.80393686219, 5616.691081990448, 5610.382857885629, 5629.605927585111, 5645.689487078168, 5672.744726487235, 5693.658380497183, 5959.374265702038, 6019.909701354483, 6028.849278768066, 6049.425304596057, 6080.422359875804, 6635.203775546869, 6672.199336079701, 6683.832904177434, 6727.360900714424, 6776.0, 1919.9136038878005, 1924.6150769846088, 1930.1314408516223, 1931.9034048297528, 1945.319138301583, 1420.453125546672, 1484.9655971319362, 1486.5877416454196, 1498.7901693762883, 1501.6546194375355, 5992.730327135289, 6095.35998720128, 6120.072177264147, 6157.045657922939, 6193.318734939153, 6623.4701223901975, 6628.5691430056895, 6629.7348106075215, 6716.865662686719, 6722.361375669304, 5987.970060149672, 6076.4531192192035, 6099.3900609938655, 6110.388961103854, 6147.508199344042, 3427.3488037272837, 3437.2438063625964, 3498.2653642734804, 3510.684038436502, 3524.3832329342777, 6979.0, 7024.578525288499, 7032.3670869620955, 7057.576545407189, 7060.6116663584, 6791.796246112624, 6799.252082270947, 6801.4558835293055, 6825.215100263434, 6837.453003759687, 7015.263397343206, 7029.121359830021, 7034.8944765828555, 7036.296370362923, 7045.89431158533, 6528.902066469102, 6621.337866213533, 6637.502187335873, 6652.7006284716335, 6694.355729486922, 6630.370114839083, 6653.434458071119, 6669.0996715444735, 6675.963831031582, 6691.832704182434, 6992.755253566101, 6999.650017499002, 7015.859682806417, 7051.294870512907, 7052.435805135474, 5454.236406902957, 5466.72666366688, 5467.289252397163, 5474.233607294902, 5496.148097044965, 6496.837579060561, 6726.9573216151575, 6737.157855268091, 6746.291639377795, 6789.524733268624, 6360.332165122781, 6457.192850893638, 6467.126937863328, 6507.479401647952, 6557.1147895035465, 6403.743850245938, 6474.1583594134345, 6495.9025614614875, 6504.252011018793, 6534.346565343428, 6310.267299525356, 6378.553501255054, 6419.422251997343, 6441.484681225585, 6444.806655800334, 6527.281998980204, 6576.539642224999, 6602.537822352389, 6613.834654133685, 6638.668066596748, 6418.807435776934, 6434.420902118832, 6440.8389790255615, 6451.54839161273, 6458.0], "value": 5245.243025175924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.1639390124487, 999.8250306196413, 1000.2148313573845, 1010.6917390195991, 1028.5680014393956, 19829.0, 20293.695594566074, 20308.39074827754, 20308.59382812343, 20318.390448286536, 18146.637067258645, 18244.0, 18347.174377153027, 18661.0, 18831.435056948278, 1024.0, 1045.6862941117672, 1045.947702614866, 1045.984310235347, 1047.0942634621035, 1056.10758908722, 1060.6870973062964, 1070.2026989892502, 1107.036877916214, 1110.4225802582653, 1144.204777679513, 1147.3861484105964, 1148.827675848621, 1148.9712757181053, 1149.2989276541302, 1089.84742136101, 1130.8247221680654, 1135.642272684102, 1138.1179585820971, 1144.5936692474177, 814.7840822182127, 816.6855760532178, 816.8978877640295, 817.0562999735315, 818.3453237410108, 20494.0, 20624.27815026467, 20665.380038598865, 20669.89665051665, 20701.0, 22176.556468870695, 22359.44101397478, 22543.323700289016, 22556.32331030072, 22574.097036118535, 17083.145842707938, 17449.738253926073, 17660.735088973677, 17666.381676641256, 17669.293228270853, 3970.463987361727, 3980.44273801668, 3994.3609022556543, 4002.959970400288, 4015.31739604268, 154495.0, 158248.0, 158649.0, 158660.0, 158902.99999999884, 17235.0, 17337.479875603753, 17383.47849564515, 17633.7354939676, 17896.105194740212, 31239.0, 33060.0, 33155.0, 33431.0, 33467.49798753021, 8644.308455323559, 8722.215000649972, 8749.47503149813, 8757.518336491426, 8768.07935166811, 4152.854650087293, 4230.280852255124, 4236.661067114624, 4237.470316210473, 4238.724482908601, 5820.126980952807, 5866.2373891393845, 5919.6152250103605, 5924.7926322578505, 5956.315023772235, 1056.5192837259028, 1072.008392237193, 1082.6102603063048, 1085.5060947268973, 1087.8368244763349, 745.4930647159983, 764.7170546897684, 766.8696321625337, 767.7351313796731, 783.060327606874, 12161.391930403444, 12546.623601291976, 12636.431360588796, 12836.422360993778, 12898.548550800864, 688.1260798785514, 704.5631708340759, 714.3499415531945, 717.7882524655239, 727.1020289941918, 4919.434265059493, 4969.478204788517, 5007.899842003212, 5040.873978150502, 5060.367454068241, 145262.0, 145677.0, 147284.0, 148237.2588137074, 149339.0, 99475.50262248643, 100019.0, 120077.0, 131976.3401182988, 135488.32255838657, 110142.44928775466, 110324.4483777576, 110516.0, 110736.0, 112702.0, 13228.735425291632, 13416.463341466622, 13536.932315338754, 13622.742528368291, 13891.861081389057, 50120.74939625279, 51003.74498127485, 52767.472325276256, 53817.73091134519, 55774.44225557693, 71088.21957226703, 71263.64368178333, 71659.0, 72184.9172262427, 72442.0, 19613.509662257988, 19642.214311427382, 19741.70387444218, 19743.80256197477, 19756.20975161035, 21880.0, 21959.67060494062, 22001.779982200613, 22029.118835246412, 22227.777722223218, 19149.0, 19158.71261931044, 19289.324873629357, 19344.41966741, 19420.0, 17713.202905869526, 17746.29014839392, 17749.467515974542, 17994.100294984935, 18000.189991450156, 16470.75293870617, 17041.403550876155, 17508.47474575765, 17931.282748689908, 17956.820431795513, 14876.851231487546, 14944.701105977601, 15091.622709431913, 15101.848981510044, 15141.0, 14215.289235538388, 14319.35562899693, 14418.855811441752, 14426.927865361025, 14458.783118253024], "value": 9849.75467641158, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1371.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 106.0, 104.0, 106.0, 106.0, 107.0, 106.0, 106.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 113.0, 111.0, 112.0, 115.0, 115.0, 112.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 161.0, 164.0, 168.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 73.0, 72.0, 74.0, 73.0, 74.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 77.0, 78.0, 77.0, 83.0, 78.0, 78.0, 79.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 116.0, 116.0, 116.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 151.0, 149.0, 149.0, 149.0, 149.0, 150.0, 151.0, 151.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 45.0, 45.0, 47.0, 45.0, 46.0, 47.0, 44.0, 45.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 71.0, 72.0, 73.0, 71.0, 73.0, 76.0, 72.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 102.0, 103.0, 111.0, 106.0, 103.0, 114.0, 103.0, 106.0, 104.0], "value": 106.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 155.0, 158.0, 154.0, 155.0, 156.0, 151.0, 154.0, 156.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 62.0], "value": 60.8, "unit": "score"}]}]} 03:39:01 INFO - Return code: 0 03:39:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:39:01 INFO - # TBPL SUCCESS # 03:39:01 INFO - Running post-action listener: _package_coverage_data 03:39:01 INFO - Running post-action listener: _resource_record_post_action 03:39:01 INFO - [mozharness: 2017-09-16 10:39:01.720460Z] Finished run-tests step (success) 03:39:01 INFO - Running post-run listener: _resource_record_post_run 03:39:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9879552; Write bytes: 456585216; Read time: 3928; Write time: 701568 03:39:01 INFO - TinderboxPrint: CPU usage
13.1% 03:39:01 INFO - TinderboxPrint: I/O read bytes / time
9,879,552 / 3,928 03:39:01 INFO - TinderboxPrint: I/O write bytes / time
456,585,216 / 701,568 03:39:01 INFO - TinderboxPrint: CPU idle
8,250.3 (86.9%) 03:39:01 INFO - TinderboxPrint: CPU user
1,186.8 (12.5%) 03:39:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:39:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12627968; Read time: 0; Write time: 2224 03:39:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:39:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 9777152; Write bytes: 443957248; Read time: 3912; Write time: 699344 03:39:02 INFO - Running post-run listener: _upload_blobber_files 03:39:02 INFO - Blob upload gear active. 03:39:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:39:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:39:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:39:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:09 INFO - (blobuploader) - INFO - Done attempting. 03:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:10 INFO - (blobuploader) - INFO - Done attempting. 03:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:39:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:11 INFO - (blobuploader) - INFO - Done attempting. 03:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:39:12 INFO - (blobuploader) - INFO - Done attempting. 03:39:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:39:12 INFO - Return code: 0 03:39:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:39:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:39:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9c359a5ac36d783cb59cdd03d40873ea25375a2b4eb88517a76393c7f4baa7c8e8401b7cd493e652643f2f95d53edb01ea6a70f552b89e3d602a3832608923", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d36356efd51b8b0f891b3366d627be83939526b4b91dc1591ba49643ffa172f55942be53ba437ecc589d75329b4740dadf5489536b6deab927dba8f1705f184", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c094143e44aa0b71dcfd5d72f78ae2befcfb63fd530d2c0ef58d3d18a517b5a6e39e13091afdfe9244c5e1bd0bd2b92ca710de65be55cc582e26f184ae3ab74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3cfc25c14f251f391188e985e3b69f44a3b4724fe09ea34d854d8ec949343101e54add403be56a3f56972f0653353a7907af22cb980e310925f72f7709ea667"} 03:39:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:39:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:39:12 INFO - Contents: 03:39:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9c359a5ac36d783cb59cdd03d40873ea25375a2b4eb88517a76393c7f4baa7c8e8401b7cd493e652643f2f95d53edb01ea6a70f552b89e3d602a3832608923", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d36356efd51b8b0f891b3366d627be83939526b4b91dc1591ba49643ffa172f55942be53ba437ecc589d75329b4740dadf5489536b6deab927dba8f1705f184", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c094143e44aa0b71dcfd5d72f78ae2befcfb63fd530d2c0ef58d3d18a517b5a6e39e13091afdfe9244c5e1bd0bd2b92ca710de65be55cc582e26f184ae3ab74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3cfc25c14f251f391188e985e3b69f44a3b4724fe09ea34d854d8ec949343101e54add403be56a3f56972f0653353a7907af22cb980e310925f72f7709ea667"} 03:39:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:39:12 INFO - Copying logs to upload dir... 03:39:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:39:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.606833 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-16 03:39:12.793089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:39:12.800326) ========= 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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 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/6b9c359a5ac36d783cb59cdd03d40873ea25375a2b4eb88517a76393c7f4baa7c8e8401b7cd493e652643f2f95d53edb01ea6a70f552b89e3d602a3832608923", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d36356efd51b8b0f891b3366d627be83939526b4b91dc1591ba49643ffa172f55942be53ba437ecc589d75329b4740dadf5489536b6deab927dba8f1705f184", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c094143e44aa0b71dcfd5d72f78ae2befcfb63fd530d2c0ef58d3d18a517b5a6e39e13091afdfe9244c5e1bd0bd2b92ca710de65be55cc582e26f184ae3ab74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3cfc25c14f251f391188e985e3b69f44a3b4724fe09ea34d854d8ec949343101e54add403be56a3f56972f0653353a7907af22cb980e310925f72f7709ea667"} build_url:https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/eeN62VmkRCGh69wutWtSzA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9c359a5ac36d783cb59cdd03d40873ea25375a2b4eb88517a76393c7f4baa7c8e8401b7cd493e652643f2f95d53edb01ea6a70f552b89e3d602a3832608923", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d36356efd51b8b0f891b3366d627be83939526b4b91dc1591ba49643ffa172f55942be53ba437ecc589d75329b4740dadf5489536b6deab927dba8f1705f184", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c094143e44aa0b71dcfd5d72f78ae2befcfb63fd530d2c0ef58d3d18a517b5a6e39e13091afdfe9244c5e1bd0bd2b92ca710de65be55cc582e26f184ae3ab74", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3cfc25c14f251f391188e985e3b69f44a3b4724fe09ea34d854d8ec949343101e54add403be56a3f56972f0653353a7907af22cb980e310925f72f7709ea667"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 03:39:12.830456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:39:12.830757) ========= 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=eca2ab57546de7b41f256b19000001ef-1505555811.253468-550782632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 03:39:12.879677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:39:12.882991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 03:39:12.883287) ========= ========= Total master_lag: 0.35 =========