builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1506947537.5 results: success (0) revision: 35998341106ce20629c30154ba5263b93ccceb70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.500567) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.500917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.501443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.531502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.531763) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 05:32:17-- 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% 224M=0s 2017-10-02 05:32:17 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132117 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.694055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.694393) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015911 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:17.768173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 05:32:17.768460) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 35998341106ce20629c30154ba5263b93ccceb70 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 35998341106ce20629c30154ba5263b93ccceb70 --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=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 05:32:17,806 truncating revision to first 12 chars 2017-10-02 05:32:17,806 Setting DEBUG logging. 2017-10-02 05:32:17,806 attempt 1/10 2017-10-02 05:32:17,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/35998341106c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 05:32:18,522 unpacking tar archive at: mozilla-beta-35998341106c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 05:32:18.824396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:18.824696) ========= script_repo_revision: 35998341106ce20629c30154ba5263b93ccceb70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:18.825053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:18.825325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 05:32:18.839520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 05:32:18.839791) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:19 INFO - MultiFileLogger online at 20171002 05:32:19 in /builds/slave/test 05:32:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 05:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:19 INFO - {'append_to_log': False, 05:32:19 INFO - 'base_work_dir': '/builds/slave/test', 05:32:19 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 05:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:19 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 05:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:19 INFO - 'code_coverage': False, 05:32:19 INFO - 'config_files': ('talos/linux_config.py',), 05:32:19 INFO - 'default_actions': ('clobber', 05:32:19 INFO - 'read-buildbot-config', 05:32:19 INFO - 'download-and-extract', 05:32:19 INFO - 'populate-webroot', 05:32:19 INFO - 'create-virtualenv', 05:32:19 INFO - 'install', 05:32:19 INFO - 'setup-mitmproxy', 05:32:19 INFO - 'run-tests'), 05:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:19 INFO - 'disable_ccov_upload': False, 05:32:19 INFO - 'disable_stylo': False, 05:32:19 INFO - 'download_minidump_stackwalk': True, 05:32:19 INFO - 'download_symbols': 'ondemand', 05:32:19 INFO - 'enable_stylo': False, 05:32:19 INFO - 'enable_webrender': False, 05:32:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:19 INFO - 'gecko_profile': False, 05:32:19 INFO - 'gecko_profile_interval': 0, 05:32:19 INFO - 'installer_path': 'installer.exe', 05:32:19 INFO - 'log_level': 'info', 05:32:19 INFO - 'log_name': 'talos', 05:32:19 INFO - 'log_to_console': True, 05:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:19 INFO - 'opt_config_files': (), 05:32:19 INFO - 'pip_index': False, 05:32:19 INFO - 'suite': 'dromaeojs-e10s', 05:32:19 INFO - 'system_bits': '32', 05:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:19 INFO - 'title': 'talos-linux64-ix-055', 05:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:19 INFO - 'use_talos_json': True, 05:32:19 INFO - 'verify': 'False', 05:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:19 INFO - 'work_dir': 'build'} 05:32:19 INFO - [mozharness: 2017-10-02 12:32:19.022672Z] Running clobber step. 05:32:19 INFO - Running pre-action listener: _resource_record_pre_action 05:32:19 INFO - Running main action method: clobber 05:32:19 INFO - rmtree: /builds/slave/test/build 05:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:20 INFO - Running post-action listener: _resource_record_post_action 05:32:20 INFO - [mozharness: 2017-10-02 12:32:20.022069Z] Finished clobber step (success) 05:32:20 INFO - [mozharness: 2017-10-02 12:32:20.022167Z] Running read-buildbot-config step. 05:32:20 INFO - Running pre-action listener: _resource_record_pre_action 05:32:20 INFO - Running main action method: read_buildbot_config 05:32:20 INFO - Using buildbot properties: 05:32:20 INFO - { 05:32:20 INFO - "project": "", 05:32:20 INFO - "product": "firefox", 05:32:20 INFO - "who": "ntim.bugs@gmail.com", 05:32:20 INFO - "installer_path": "public/build/target.tar.bz2", 05:32:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:32:20 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 05:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 05:32:20 INFO - "stage_platform": "linux64", 05:32:20 INFO - "basedir": "/builds/slave/test", 05:32:20 INFO - "buildnumber": 142, 05:32:20 INFO - "platform": "ubuntu64_hw", 05:32:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:32:20 INFO - "slavebuilddir": "test", 05:32:20 INFO - "taskId": "b8rk3dtLTiqQZzJwupJyjg", 05:32:20 INFO - "branch": "mozilla-beta", 05:32:20 INFO - "script_repo_revision": "production", 05:32:20 INFO - "revision": "35998341106ce20629c30154ba5263b93ccceb70", 05:32:20 INFO - "slavename": "talos-linux64-ix-055", 05:32:20 INFO - "repo_path": "releases/mozilla-beta" 05:32:20 INFO - } 05:32:20 INFO - Finding installer, test and symbols from parent task. 05:32:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8rk3dtLTiqQZzJwupJyjg'}, attempt #1 05:32:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b8rk3dtLTiqQZzJwupJyjg'}, attempt #1 05:32:20 INFO - Task dependencies: DsGFmAXuTpak9zr5OJMekw 05:32:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw'}, attempt #1 05:32:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 05:32:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.test_packages.json 05:32:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.crashreporter-symbols.zip 05:32:21 INFO - Running post-action listener: _resource_record_post_action 05:32:21 INFO - [mozharness: 2017-10-02 12:32:21.437833Z] Finished read-buildbot-config step (success) 05:32:21 INFO - [mozharness: 2017-10-02 12:32:21.438145Z] Running download-and-extract step. 05:32:21 INFO - Running pre-action listener: _resource_record_pre_action 05:32:21 INFO - Running main action method: download_and_extract 05:32:21 INFO - mkdir: /builds/slave/test/build/tests 05:32:21 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')]} 05:32:21 INFO - trying https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.test_packages.json 05:32:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:32:22 INFO - Downloaded 989 bytes. 05:32:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:32:22 INFO - Using the following test package requirements: 05:32:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:32:22 INFO - u'common': [u'target.common.tests.zip'], 05:32:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:32:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:32:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:32:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:32:22 INFO - u'mozbase': [u'target.common.tests.zip'], 05:32:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:32:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:32:22 INFO - u'web-platform': [u'target.common.tests.zip', 05:32:22 INFO - u'target.web-platform.tests.tar.gz'], 05:32:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:32:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:32:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.common.tests.zip 05:32:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:22 INFO - Fetch https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.common.tests.zip into memory 05:32:23 INFO - Content-Length response header: 55177961 05:32:23 INFO - Bytes received: 55177961 05:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.talos.tests.zip 05:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.talos.tests.zip into memory 05:32:36 INFO - Content-Length response header: 14509184 05:32:36 INFO - Bytes received: 14509184 05:32:36 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')]} 05:32:36 INFO - trying https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 05:32:36 INFO - Downloading https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:32:39 INFO - Downloaded 53490033 bytes. 05:32:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 05:32:39 INFO - mkdir: /builds/slave/test/properties 05:32:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:39 INFO - Contents: 05:32:39 INFO - build_url:https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 05:32:39 INFO - Running post-action listener: _resource_record_post_action 05:32:39 INFO - Running post-action listener: find_tests_for_verification 05:32:39 INFO - Running post-action listener: set_extra_try_arguments 05:32:39 INFO - [mozharness: 2017-10-02 12:32:39.504393Z] Finished download-and-extract step (success) 05:32:39 INFO - [mozharness: 2017-10-02 12:32:39.504492Z] Running populate-webroot step. 05:32:39 INFO - Running pre-action listener: _resource_record_pre_action 05:32:39 INFO - Running main action method: populate_webroot 05:32:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:39 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['tresize', 05:32:39 INFO - 'tcanvasmark']}, 05:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:39 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['dromaeo_css', 05:32:39 INFO - 'kraken']}, 05:32:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:39 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'tests': ['damp', 'tps']}, 05:32:39 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['damp', 'tps']}, 05:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:39 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['dromaeo_dom']}, 05:32:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:32:39 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['basic_compositor_video', 05:32:39 INFO - 'glvideo']}, 05:32:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:32:39 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['ts_paint_webext', 05:32:39 INFO - 'tp5o_webext']}, 05:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:39 INFO - 'ts_paint', 05:32:39 INFO - 'tpaint', 05:32:39 INFO - 'sessionrestore', 05:32:39 INFO - 'sessionrestore_many_windows', 05:32:39 INFO - 'sessionrestore_no_auto_restore', 05:32:39 INFO - 'tabpaint']}, 05:32:39 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['a11yr', 05:32:39 INFO - 'ts_paint', 05:32:39 INFO - 'tpaint', 05:32:39 INFO - 'sessionrestore', 05:32:39 INFO - 'sessionrestore_many_windows', 05:32:39 INFO - 'sessionrestore_no_auto_restore', 05:32:39 INFO - 'tabpaint']}, 05:32:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:32:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:32:39 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['perf_reftest_singletons']}, 05:32:39 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['bloom_basic']}, 05:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:39 INFO - 'tsvgr_opacity', 05:32:39 INFO - 'tart', 05:32:39 INFO - 'tscrollx', 05:32:39 INFO - 'tsvg_static']}, 05:32:39 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['tsvgx', 05:32:39 INFO - 'tsvgr_opacity', 05:32:39 INFO - 'tart', 05:32:39 INFO - 'tscrollx', 05:32:39 INFO - 'tsvg_static']}, 05:32:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:32:39 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo'], 05:32:39 INFO - 'tests': ['tp5o']}, 05:32:39 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:32:39 INFO - 'talos_options': ['--mitmproxy', 05:32:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:32:39 INFO - '--firstNonBlankPaint'], 05:32:39 INFO - 'tests': ['tp6_google', 05:32:39 INFO - 'tp6_youtube', 05:32:39 INFO - 'tp6_amazon', 05:32:39 INFO - 'tp6_facebook']}, 05:32:39 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo', 05:32:39 INFO - '--mitmproxy', 05:32:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:32:39 INFO - '--firstNonBlankPaint'], 05:32:39 INFO - 'tests': ['tp6_google', 05:32:39 INFO - 'tp6_youtube', 05:32:39 INFO - 'tp6_amazon', 05:32:39 INFO - 'tp6_facebook']}, 05:32:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:32:39 INFO - 'talos_options': ['--stylo-threads=1', 05:32:39 INFO - '--mitmproxy', 05:32:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:32:39 INFO - '--firstNonBlankPaint'], 05:32:39 INFO - 'tests': ['tp6_google', 05:32:39 INFO - 'tp6_youtube', 05:32:39 INFO - 'tp6_amazon', 05:32:39 INFO - 'tp6_facebook']}, 05:32:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--xperf_path', 05:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:39 INFO - 'tests': ['tp5n']}, 05:32:39 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:32:39 INFO - 'talos_options': ['--disable-stylo', 05:32:39 INFO - '--xperf_path', 05:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:39 INFO - 'tests': ['tp5n']}}} 05:32:39 INFO - Running post-action listener: _resource_record_post_action 05:32:39 INFO - [mozharness: 2017-10-02 12:32:39.519623Z] Finished populate-webroot step (success) 05:32:39 INFO - [mozharness: 2017-10-02 12:32:39.519713Z] Running create-virtualenv step. 05:32:39 INFO - Running pre-action listener: _resource_record_pre_action 05:32:39 INFO - Running main action method: create_virtualenv 05:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:39 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:32:39 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:32:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:40 INFO - Installing pip...............done. 05:32:40 INFO - Return code: 0 05:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:40 INFO - Reading from file tmpfile_stdout 05:32:40 INFO - Output received: 05:32:40 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:32:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:40 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')]} 05:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:40 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')]} 05:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:40 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:40 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 05:32:40 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 05:32:40 INFO - Using env: {'DISPLAY': ':0', 05:32:40 INFO - 'HOME': '/home/cltbld', 05:32:40 INFO - 'LANG': 'en_US.UTF-8', 05:32:40 INFO - 'LANGUAGE': 'en_US:en', 05:32:40 INFO - 'LOGNAME': 'cltbld', 05:32:40 INFO - 'MAIL': '/var/mail/cltbld', 05:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:40 INFO - 'MOZ_NO_REMOTE': '1', 05:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:40 INFO - 'NO_EM_RESTART': '1', 05:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:40 INFO - 'PWD': '/builds/slave/test', 05:32:40 INFO - 'SHELL': '/bin/bash', 05:32:40 INFO - 'SHLVL': '1', 05:32:40 INFO - 'TERM': 'linux', 05:32:40 INFO - 'TMOUT': '86400', 05:32:40 INFO - 'USER': 'cltbld', 05:32:40 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:40 INFO - '_': '/tools/buildbot/bin/python'} 05:32:41 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:32:41 INFO - Downloading/unpacking pip>=1.5 05:32:41 INFO - Running setup.py egg_info for package pip 05:32:41 INFO - warning: no files found matching 'pip/cacert.pem' 05:32:41 INFO - warning: no files found matching '*.html' under directory 'docs' 05:32:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:32:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:32:41 INFO - Installing collected packages: pip 05:32:41 INFO - Found existing installation: pip 1.1 05:32:41 INFO - Uninstalling pip: 05:32:41 INFO - Successfully uninstalled pip 05:32:41 INFO - Running setup.py install for pip 05:32:41 INFO - warning: no files found matching 'pip/cacert.pem' 05:32:41 INFO - warning: no files found matching '*.html' under directory 'docs' 05:32:41 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:32:41 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:32:41 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Successfully installed pip 05:32:41 INFO - Cleaning up... 05:32:41 INFO - Return code: 0 05:32:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32:41 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')]} 05:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:41 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')]} 05:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:41 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:41 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 05:32:41 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 05:32:41 INFO - Using env: {'DISPLAY': ':0', 05:32:41 INFO - 'HOME': '/home/cltbld', 05:32:41 INFO - 'LANG': 'en_US.UTF-8', 05:32:41 INFO - 'LANGUAGE': 'en_US:en', 05:32:41 INFO - 'LOGNAME': 'cltbld', 05:32:41 INFO - 'MAIL': '/var/mail/cltbld', 05:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:41 INFO - 'MOZ_NO_REMOTE': '1', 05:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:41 INFO - 'NO_EM_RESTART': '1', 05:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:41 INFO - 'PWD': '/builds/slave/test', 05:32:41 INFO - 'SHELL': '/bin/bash', 05:32:41 INFO - 'SHLVL': '1', 05:32:41 INFO - 'TERM': 'linux', 05:32:41 INFO - 'TMOUT': '86400', 05:32:41 INFO - 'USER': 'cltbld', 05:32:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:41 INFO - '_': '/tools/buildbot/bin/python'} 05:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:42 INFO - Downloading/unpacking psutil>=3.1.1 05:32:42 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 05:32:42 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 05:32:42 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 05:32:42 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 05:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:43 INFO - Installing collected packages: psutil 05:32:43 INFO - Running setup.py install for psutil 05:32:43 INFO - building 'psutil._psutil_linux' extension 05:32:43 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 05:32:43 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 05:32:43 INFO - building 'psutil._psutil_posix' extension 05:32:43 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 05:32:43 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 05:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:43 INFO - Successfully installed psutil 05:32:43 INFO - Cleaning up... 05:32:43 INFO - Return code: 0 05:32:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32:43 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')]} 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:43 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')]} 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:43 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:43 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 05:32:43 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 05:32:43 INFO - Using env: {'DISPLAY': ':0', 05:32:43 INFO - 'HOME': '/home/cltbld', 05:32:43 INFO - 'LANG': 'en_US.UTF-8', 05:32:43 INFO - 'LANGUAGE': 'en_US:en', 05:32:43 INFO - 'LOGNAME': 'cltbld', 05:32:43 INFO - 'MAIL': '/var/mail/cltbld', 05:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:43 INFO - 'MOZ_NO_REMOTE': '1', 05:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:43 INFO - 'NO_EM_RESTART': '1', 05:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:43 INFO - 'PWD': '/builds/slave/test', 05:32:43 INFO - 'SHELL': '/bin/bash', 05:32:43 INFO - 'SHLVL': '1', 05:32:43 INFO - 'TERM': 'linux', 05:32:43 INFO - 'TMOUT': '86400', 05:32:43 INFO - 'USER': 'cltbld', 05:32:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:43 INFO - '_': '/tools/buildbot/bin/python'} 05:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:43 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 05:32:43 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 05:32:43 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 05:32:43 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 05:32:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:45 INFO - Installing collected packages: mozsystemmonitor 05:32:45 INFO - Running setup.py install for mozsystemmonitor 05:32:45 INFO - Successfully installed mozsystemmonitor 05:32:45 INFO - Cleaning up... 05:32:45 INFO - Return code: 0 05:32:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:45 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:45 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 05:32:45 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 05:32:45 INFO - Using env: {'DISPLAY': ':0', 05:32:45 INFO - 'HOME': '/home/cltbld', 05:32:45 INFO - 'LANG': 'en_US.UTF-8', 05:32:45 INFO - 'LANGUAGE': 'en_US:en', 05:32:45 INFO - 'LOGNAME': 'cltbld', 05:32:45 INFO - 'MAIL': '/var/mail/cltbld', 05:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:45 INFO - 'MOZ_NO_REMOTE': '1', 05:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:45 INFO - 'NO_EM_RESTART': '1', 05:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:45 INFO - 'PWD': '/builds/slave/test', 05:32:45 INFO - 'SHELL': '/bin/bash', 05:32:45 INFO - 'SHLVL': '1', 05:32:45 INFO - 'TERM': 'linux', 05:32:45 INFO - 'TMOUT': '86400', 05:32:45 INFO - 'USER': 'cltbld', 05:32:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:45 INFO - '_': '/tools/buildbot/bin/python'} 05:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:46 INFO - Downloading/unpacking jsonschema==2.5.1 05:32:46 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 05:32:46 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 05:32:46 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 05:32:46 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 05:32:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:47 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 05:32:47 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 05:32:47 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 05:32:47 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 05:32:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:47 INFO - warning: no files found matching '*.txt' 05:32:47 INFO - no previously-included directories found matching 'build' 05:32:47 INFO - no previously-included directories found matching 'dist' 05:32:47 INFO - no previously-included directories found matching '.git*' 05:32:47 INFO - Installing collected packages: jsonschema, functools32 05:32:47 INFO - Running setup.py install for functools32 05:32:48 INFO - warning: no files found matching '*.txt' 05:32:48 INFO - no previously-included directories found matching 'build' 05:32:48 INFO - no previously-included directories found matching 'dist' 05:32:48 INFO - no previously-included directories found matching '.git*' 05:32:48 INFO - Successfully installed jsonschema functools32 05:32:48 INFO - Cleaning up... 05:32:48 INFO - Return code: 0 05:32:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:32:48 INFO - Using env: {'DISPLAY': ':0', 05:32:48 INFO - 'HOME': '/home/cltbld', 05:32:48 INFO - 'LANG': 'en_US.UTF-8', 05:32:48 INFO - 'LANGUAGE': 'en_US:en', 05:32:48 INFO - 'LOGNAME': 'cltbld', 05:32:48 INFO - 'MAIL': '/var/mail/cltbld', 05:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:48 INFO - 'MOZ_NO_REMOTE': '1', 05:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:48 INFO - 'NO_EM_RESTART': '1', 05:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:48 INFO - 'PWD': '/builds/slave/test', 05:32:48 INFO - 'SHELL': '/bin/bash', 05:32:48 INFO - 'SHLVL': '1', 05:32:48 INFO - 'TERM': 'linux', 05:32:48 INFO - 'TMOUT': '86400', 05:32:48 INFO - 'USER': 'cltbld', 05:32:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:48 INFO - '_': '/tools/buildbot/bin/python'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:48 INFO - Cleaning up... 05:32:48 INFO - Return code: 0 05:32:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:32:48 INFO - Using env: {'DISPLAY': ':0', 05:32:48 INFO - 'HOME': '/home/cltbld', 05:32:48 INFO - 'LANG': 'en_US.UTF-8', 05:32:48 INFO - 'LANGUAGE': 'en_US:en', 05:32:48 INFO - 'LOGNAME': 'cltbld', 05:32:48 INFO - 'MAIL': '/var/mail/cltbld', 05:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:48 INFO - 'MOZ_NO_REMOTE': '1', 05:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:48 INFO - 'NO_EM_RESTART': '1', 05:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:48 INFO - 'PWD': '/builds/slave/test', 05:32:48 INFO - 'SHELL': '/bin/bash', 05:32:48 INFO - 'SHLVL': '1', 05:32:48 INFO - 'TERM': 'linux', 05:32:48 INFO - 'TMOUT': '86400', 05:32:48 INFO - 'USER': 'cltbld', 05:32:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:48 INFO - '_': '/tools/buildbot/bin/python'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:48 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 05:32:48 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 05:32:48 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 05:32:48 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 05:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:50 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 05:32:50 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 05:32:50 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 05:32:50 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 05:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:50 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 05:32:50 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 05:32:50 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 05:32:50 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 05:32:50 INFO - Downloading docopt-0.6.1.tar.gz 05:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:50 INFO - Running setup.py install for blobuploader 05:32:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:50 INFO - Running setup.py install for requests 05:32:51 INFO - Running setup.py install for docopt 05:32:51 INFO - Successfully installed blobuploader requests docopt 05:32:51 INFO - Cleaning up... 05:32:51 INFO - Return code: 0 05:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32: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')]} 05:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:51 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:51 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 05:32:51 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 05:32:51 INFO - Using env: {'DISPLAY': ':0', 05:32:51 INFO - 'HOME': '/home/cltbld', 05:32:51 INFO - 'LANG': 'en_US.UTF-8', 05:32:51 INFO - 'LANGUAGE': 'en_US:en', 05:32:51 INFO - 'LOGNAME': 'cltbld', 05:32:51 INFO - 'MAIL': '/var/mail/cltbld', 05:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:51 INFO - 'MOZ_NO_REMOTE': '1', 05:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:51 INFO - 'NO_EM_RESTART': '1', 05:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:51 INFO - 'PWD': '/builds/slave/test', 05:32:51 INFO - 'SHELL': '/bin/bash', 05:32:51 INFO - 'SHLVL': '1', 05:32:51 INFO - 'TERM': 'linux', 05:32:51 INFO - 'TMOUT': '86400', 05:32:51 INFO - 'USER': 'cltbld', 05:32:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:51 INFO - '_': '/tools/buildbot/bin/python'} 05:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:51 INFO - Running setup.py (path:/tmp/pip-dcqmmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:51 INFO - Running setup.py (path:/tmp/pip-XhTqzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:51 INFO - Running setup.py (path:/tmp/pip-Lsuuej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:51 INFO - Running setup.py (path:/tmp/pip-0GLs5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:51 INFO - Running setup.py (path:/tmp/pip-S4isbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:51 INFO - Running setup.py (path:/tmp/pip-2Jnk49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:51 INFO - Running setup.py (path:/tmp/pip-XEuOao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:51 INFO - Running setup.py (path:/tmp/pip-GfPnY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:51 INFO - Running setup.py (path:/tmp/pip-LB18Pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:52 INFO - Running setup.py (path:/tmp/pip-gIC7Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:52 INFO - Running setup.py (path:/tmp/pip-zU6FyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:52 INFO - Running setup.py (path:/tmp/pip-jkEQgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:52 INFO - Running setup.py (path:/tmp/pip-X5Ik_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:52 INFO - Running setup.py (path:/tmp/pip-IsnGq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:52 INFO - Running setup.py (path:/tmp/pip-zSMA86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:52 INFO - Running setup.py (path:/tmp/pip-X_RI6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:52 INFO - Running setup.py (path:/tmp/pip-OL3BdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:52 INFO - Running setup.py install for manifestparser 05:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:52 INFO - Running setup.py install for mozcrash 05:32:52 INFO - Running setup.py install for mozdebug 05:32:52 INFO - Running setup.py install for mozdevice 05:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:52 INFO - Running setup.py install for mozfile 05:32:53 INFO - Running setup.py install for mozhttpd 05:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozinfo 05:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozInstall 05:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozleak 05:32:53 INFO - Running setup.py install for mozlog 05:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for moznetwork 05:32:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozprocess 05:32:53 INFO - Running setup.py install for mozprofile 05:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:53 INFO - Running setup.py install for mozrunner 05:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Running setup.py install for mozscreenshot 05:32:54 INFO - Running setup.py install for moztest 05:32:54 INFO - Running setup.py install for mozversion 05:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:54 INFO - Cleaning up... 05:32:54 INFO - Return code: 0 05:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32: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')]} 05:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:54 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:54 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 05:32:54 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 05:32:54 INFO - Using env: {'DISPLAY': ':0', 05:32:54 INFO - 'HOME': '/home/cltbld', 05:32:54 INFO - 'LANG': 'en_US.UTF-8', 05:32:54 INFO - 'LANGUAGE': 'en_US:en', 05:32:54 INFO - 'LOGNAME': 'cltbld', 05:32:54 INFO - 'MAIL': '/var/mail/cltbld', 05:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:54 INFO - 'MOZ_NO_REMOTE': '1', 05:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:54 INFO - 'NO_EM_RESTART': '1', 05:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:54 INFO - 'PWD': '/builds/slave/test', 05:32:54 INFO - 'SHELL': '/bin/bash', 05:32:54 INFO - 'SHLVL': '1', 05:32:54 INFO - 'TERM': 'linux', 05:32:54 INFO - 'TMOUT': '86400', 05:32:54 INFO - 'USER': 'cltbld', 05:32:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:54 INFO - '_': '/tools/buildbot/bin/python'} 05:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:54 INFO - Running setup.py (path:/tmp/pip-89l9fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:54 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)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:54 INFO - Running setup.py (path:/tmp/pip-gzigE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:54 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)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:54 INFO - Running setup.py (path:/tmp/pip-fPEqXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:54 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)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:54 INFO - Running setup.py (path:/tmp/pip-ncw9jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:54 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)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:54 INFO - Running setup.py (path:/tmp/pip-yb6QSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:54 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)) 05:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:54 INFO - Running setup.py (path:/tmp/pip-vruYL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:54 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:55 INFO - Running setup.py (path:/tmp/pip-2oNmFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:55 INFO - Running setup.py (path:/tmp/pip-ZHjFE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:55 INFO - Running setup.py (path:/tmp/pip-ssG0pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:55 INFO - Running setup.py (path:/tmp/pip-9LVdLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:55 INFO - Running setup.py (path:/tmp/pip-nUs8ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:55 INFO - Running setup.py (path:/tmp/pip-RCofoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:55 INFO - Running setup.py (path:/tmp/pip-Fl2M9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:55 INFO - Running setup.py (path:/tmp/pip-GfeSgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:55 INFO - Running setup.py (path:/tmp/pip-1N_lIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:55 INFO - Running setup.py (path:/tmp/pip-ALe4fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:55 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)) 05:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:55 INFO - Running setup.py (path:/tmp/pip-F0KCXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 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)) 05:32:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32: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 05:32: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 05:32: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 05:32: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 05:32:56 INFO - Downloading blessings-1.6.tar.gz 05:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:57 INFO - Installing collected packages: blessings 05:32:57 INFO - Running setup.py install for blessings 05:32:57 INFO - Successfully installed blessings 05:32:57 INFO - Cleaning up... 05:32:57 INFO - Return code: 0 05:32:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:57 INFO - Reading from file tmpfile_stdout 05:32:57 INFO - Current package versions: 05:32:57 INFO - argparse == 1.2.1 05:32:57 INFO - blessings == 1.6 05:32:57 INFO - blobuploader == 1.2.4 05:32:57 INFO - docopt == 0.6.1 05:32:57 INFO - functools32 == 3.2.3-2 05:32:57 INFO - jsonschema == 2.5.1 05:32:57 INFO - manifestparser == 1.1 05:32:57 INFO - mozInstall == 1.13 05:32:57 INFO - mozcrash == 1.0 05:32:57 INFO - mozdebug == 0.1 05:32:57 INFO - mozdevice == 0.51 05:32:57 INFO - mozfile == 1.2 05:32:57 INFO - mozhttpd == 0.7 05:32:57 INFO - mozinfo == 0.10 05:32:57 INFO - mozleak == 0.1 05:32:57 INFO - mozlog == 3.5 05:32:57 INFO - moznetwork == 0.27 05:32:57 INFO - mozprocess == 0.25 05:32:57 INFO - mozprofile == 0.28 05:32:57 INFO - mozrunner == 6.13 05:32:57 INFO - mozscreenshot == 0.1 05:32:57 INFO - mozsystemmonitor == 0.3 05:32:57 INFO - moztest == 0.8 05:32:57 INFO - mozversion == 1.4 05:32:57 INFO - psutil == 3.1.1 05:32:57 INFO - requests == 1.2.3 05:32:57 INFO - wsgiref == 0.1.2 05:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:57 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 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:57 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 05:32:57 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 05:32:57 INFO - Using env: {'DISPLAY': ':0', 05:32:57 INFO - 'HOME': '/home/cltbld', 05:32:57 INFO - 'LANG': 'en_US.UTF-8', 05:32:57 INFO - 'LANGUAGE': 'en_US:en', 05:32:57 INFO - 'LOGNAME': 'cltbld', 05:32:57 INFO - 'MAIL': '/var/mail/cltbld', 05:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:57 INFO - 'MOZ_NO_REMOTE': '1', 05:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:57 INFO - 'NO_EM_RESTART': '1', 05:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:57 INFO - 'PWD': '/builds/slave/test', 05:32:57 INFO - 'SHELL': '/bin/bash', 05:32:57 INFO - 'SHLVL': '1', 05:32:57 INFO - 'TERM': 'linux', 05:32:57 INFO - 'TMOUT': '86400', 05:32:57 INFO - 'USER': 'cltbld', 05:32:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:57 INFO - '_': '/tools/buildbot/bin/python'} 05:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 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)) 05:32:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:32: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 05:32: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 05:32: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 05:32: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 05:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:32:58 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)) 05:32:58 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)) 05:32:58 INFO - Installing collected packages: simplejson 05:32:58 INFO - Running setup.py install for simplejson 05:32:58 INFO - building 'simplejson._speedups' extension 05:32:58 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 05:32:59 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 05:32:59 INFO - Successfully installed simplejson 05:32:59 INFO - Cleaning up... 05:32:59 INFO - Return code: 0 05:32:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2881a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a24a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', '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 05:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:59 INFO - Using env: {'DISPLAY': ':0', 05:32:59 INFO - 'HOME': '/home/cltbld', 05:32:59 INFO - 'LANG': 'en_US.UTF-8', 05:32:59 INFO - 'LANGUAGE': 'en_US:en', 05:32:59 INFO - 'LOGNAME': 'cltbld', 05:32:59 INFO - 'MAIL': '/var/mail/cltbld', 05:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:59 INFO - 'MOZ_NO_REMOTE': '1', 05:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:32:59 INFO - 'NO_EM_RESTART': '1', 05:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:59 INFO - 'PWD': '/builds/slave/test', 05:32:59 INFO - 'SHELL': '/bin/bash', 05:32:59 INFO - 'SHLVL': '1', 05:32:59 INFO - 'TERM': 'linux', 05:32:59 INFO - 'TMOUT': '86400', 05:32:59 INFO - 'USER': 'cltbld', 05:32:59 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:59 INFO - '_': '/tools/buildbot/bin/python'} 05:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:00 INFO - Cleaning up... 05:33:00 INFO - Return code: 0 05:33:00 INFO - Running post-action listener: _resource_record_post_action 05:33:00 INFO - Running post-action listener: _start_resource_monitoring 05:33:00 INFO - Starting resource monitoring. 05:33:00 INFO - [mozharness: 2017-10-02 12:33:00.084461Z] Finished create-virtualenv step (success) 05:33:00 INFO - [mozharness: 2017-10-02 12:33:00.084974Z] Running install step. 05:33:00 INFO - Running pre-action listener: _resource_record_pre_action 05:33:00 INFO - Running main action method: install 05:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:00 INFO - Reading from file tmpfile_stdout 05:33:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:00 INFO - Reading from file tmpfile_stdout 05:33:00 INFO - Output received: 05:33:00 INFO - Usage: mozinstall [options] installer 05:33:00 INFO - Options: 05:33:00 INFO - -h, --help show this help message and exit 05:33:00 INFO - -d DEST, --destination=DEST 05:33:00 INFO - Directory to install application into. [default: 05:33:00 INFO - "/builds/slave/test"] 05:33:00 INFO - --app=APP Application being installed. [default: firefox] 05:33:00 INFO - mkdir: /builds/slave/test/build/application 05:33:00 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'] 05:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:33:14 INFO - Reading from file tmpfile_stdout 05:33:14 INFO - Output received: 05:33:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:14 INFO - Running post-action listener: _resource_record_post_action 05:33:14 INFO - [mozharness: 2017-10-02 12:33:14.998313Z] Finished install step (success) 05:33:14 INFO - [mozharness: 2017-10-02 12:33:14.998563Z] Running setup-mitmproxy step. 05:33:14 INFO - Running pre-action listener: _resource_record_pre_action 05:33:14 INFO - Running main action method: setup_mitmproxy 05:33:14 INFO - Skipping: mitmproxy is not required 05:33:14 INFO - Running post-action listener: _resource_record_post_action 05:33:14 INFO - [mozharness: 2017-10-02 12:33:14.999696Z] Finished setup-mitmproxy step (success) 05:33:14 INFO - [mozharness: 2017-10-02 12:33:14.999916Z] Running run-tests step. 05:33:15 INFO - Running pre-action listener: _resource_record_pre_action 05:33:15 INFO - Running pre-action listener: _set_gcov_prefix 05:33:15 INFO - Running main action method: run_tests 05:33:15 WARNING - Try message not found. 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:15 INFO - Python 2.7.3 05:33:15 INFO - Return code: 0 05:33:15 INFO - grabbing minidump binary from tooltool 05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:15 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 0x2a28090>, '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 0x2a28d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a22f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:15 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 05:33:15 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 05:33:15 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 05:33:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:15 INFO - Return code: 0 05:33:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - ENV: RUST_BACKTRACE is now full 05:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 05:33:15 INFO - Using env: {'DISPLAY': ':0', 05:33:15 INFO - 'HOME': '/home/cltbld', 05:33:15 INFO - 'LANG': 'en_US.UTF-8', 05:33:15 INFO - 'LANGUAGE': 'en_US:en', 05:33:15 INFO - 'LOGNAME': 'cltbld', 05:33:15 INFO - 'MAIL': '/var/mail/cltbld', 05:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:15 INFO - 'MOZ_NO_REMOTE': '1', 05:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:15 INFO - 'NO_EM_RESTART': '1', 05:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:15 INFO - 'PWD': '/builds/slave/test', 05:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:15 INFO - 'RUST_BACKTRACE': 'full', 05:33:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:33:15 INFO - 'SHELL': '/bin/bash', 05:33:15 INFO - 'SHLVL': '1', 05:33:15 INFO - 'TERM': 'linux', 05:33:15 INFO - 'TMOUT': '86400', 05:33:15 INFO - 'USER': 'cltbld', 05:33:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:15 INFO - '_': '/tools/buildbot/bin/python'} 05:33:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 05:33:15 INFO - mozversion application_buildid: 20171002111215 05:33:15 INFO - mozversion application_changeset: 35998341106ce20629c30154ba5263b93ccceb70 05:33:15 INFO - mozversion application_display_name: Firefox 05:33:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:15 INFO - mozversion application_name: Firefox 05:33:15 INFO - mozversion application_remotingname: firefox 05:33:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:33:15 INFO - mozversion application_vendor: Mozilla 05:33:15 INFO - mozversion application_version: 57.0 05:33:15 INFO - mozversion platform_buildid: 20171002111215 05:33:15 INFO - mozversion platform_changeset: 35998341106ce20629c30154ba5263b93ccceb70 05:33:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:33:15 INFO - mozversion platform_version: 57.0 05:33:15 INFO - using testdate: 1506947595 05:33:15 INFO - actual date: 1506947595 05:33:15 INFO - starting webserver on 'localhost:37572' 05:33:15 INFO - SUITE-START | Running 2 tests 05:33:15 INFO - TEST-START | dromaeo_css 05:33:15 INFO - Initialising browser for dromaeo_css test... 05:33:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37572/getInfo.html -profile /tmp/tmpZIbAE3/profile 05:33:15 INFO - TEST-INFO | started process 21341 (/builds/slave/test/build/application/firefox/firefox http://localhost:37572/getInfo.html) 05:33:20 INFO - TEST-INFO | 21341: exit 0 05:33:20 INFO - Browser initialized. 05:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:20 INFO - Using env: {'DISPLAY': ':0', 05:33:20 INFO - 'HOME': '/home/cltbld', 05:33:20 INFO - 'JSGC_DISABLE_POISONING': '1', 05:33:20 INFO - 'LANG': 'en_US.UTF-8', 05:33:20 INFO - 'LANGUAGE': 'en_US:en', 05:33:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:33:20 INFO - 'LOGNAME': 'cltbld', 05:33:20 INFO - 'MAIL': '/var/mail/cltbld', 05:33:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:20 INFO - 'MOZ_CRASHREPORTER': '1', 05:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:33:20 INFO - 'MOZ_NO_REMOTE': '1', 05:33:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:20 INFO - 'NO_EM_RESTART': '1', 05:33:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:20 INFO - 'PWD': '/builds/slave/test', 05:33:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:20 INFO - 'RUST_BACKTRACE': 'full', 05:33:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:33:20 INFO - 'SHELL': '/bin/bash', 05:33:20 INFO - 'SHLVL': '1', 05:33:20 INFO - 'TERM': 'linux', 05:33:20 INFO - 'TMOUT': '86400', 05:33:20 INFO - 'USER': 'cltbld', 05:33:20 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:20 INFO - '_': '/tools/buildbot/bin/python'} 05:33:20 INFO - TEST-INFO | started process 21534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZIbAE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:21 INFO - PID 21534 | 05:33:21 INFO - PID 21534 | (/builds/slave/test/build/application/firefox/firefox:21582): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:33:21 INFO - PID 21534 | 05:33:31 INFO - PID 21534 | RSS: Main: 140857344 05:33:31 INFO - PID 21534 | 05:36:28 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37572/tests/dromaeo/cssquery-ext.html) 05:36:30 INFO - PID 21534 | RSS: Main: 144797696 05:36:30 INFO - PID 21534 | 05:39:31 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-ext.html (next: http://localhost:37572/tests/dromaeo/cssquery-jquery.html) 05:39:32 INFO - PID 21534 | RSS: Main: 141758464 05:39:32 INFO - PID 21534 | 05:42:33 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37572/tests/dromaeo/cssquery-mootools.html) 05:42:34 INFO - PID 21534 | RSS: Main: 144343040 05:42:34 INFO - PID 21534 | 05:45:35 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37572/tests/dromaeo/cssquery-prototype.html) 05:45:36 INFO - PID 21534 | RSS: Main: 144859136 05:45:36 INFO - PID 21534 | 05:48:39 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37572/tests/dromaeo/cssquery-yui.html) 05:48:40 INFO - PID 21534 | RSS: Main: 145690624 05:48:40 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | Cycle 1(1): loaded http://localhost:37572/tests/dromaeo/cssquery-yui.html (next: http://localhost:37572/tests/dromaeo/cssquery-dojo.html) 05:51:41 INFO - PID 21534 | RSS: Main: 148545536 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | __start_tp_report 05:51:41 INFO - PID 21534 | _x_x_mozilla_page_load 05:51:41 INFO - PID 21534 | _x_x_mozilla_page_load_details 05:51:41 INFO - PID 21534 | |i|pagename|runs| 05:51:41 INFO - PID 21534 | |0;dojo.html;4026.9798651006745;4037.777922214279;4049.838006479741;4060.4518390017356;4067.816948237331;6458.935410645892;6568.507361947861;6637.236717777457;6668.966655166723;6678.265390807013;6539.346065393458;6579.736810527573;6608.669566521667;6661.4670826333895;6665.900011499819;5912.497437717778;5931.614445061057;5959.761609535635;5969.224000879891;6008.098785182214;5880.323762767293;5982.46157845796;5990.460858522732;6058.1518587397795;6063.575549711522;5943;5970.641761494303;5973.074173503114;5986.311574168961;6003.489703375197;5916.26046744157;6009;6061.969690151565;6065.696715164224;6067.393260673919;5884.705764711747;5957.731902064417;5977.820665380045;5981.043033114681;6057.30341010785;6464.709088091047;6520.804375868732;6529.412352888263;6532.5753826001155;6559.376859198369;7089;7189.1013623297085;7195.208527062019;7205.099362579677;7207.207207207203;7130.5365151265005;7131.89302160468;7151.141862976424;7172.0676312079095;7225.602591857446;6442.323556026597;6697.799066027978;6698.56459330142;6699.832504187337;6701.09535212745;7282.3145908458555;7376.373008294355;7378.815529611803;7394.186639469654;7399.48203625741;7066.293370662893;7078.25678303781;7147.82130446743;7160;7167.605781682058;7198.208197098315;7206.819829504199;7288.489805713549;7294.854102917912;7308.488405811649;6998.930010699828;7076.363127318463;7088.291170882973;7160.10498687664;7231.89152162718;6748.83127921796;7094.751683691046;7106.467014973794;7122.501424900311;7124.679389427488;5304.496072873071;5377.166539186433;5377.623566350318;5378.73106344689;5382.3541175059245;4788.952110478851;4793.376861008047;4832.130216561053;4863.294822250825;4867.634927380461;6560.737570497222;6598.3401659833635;6682.064510968468;6714.060031595581;6714.1271634688155;7048.964755176191;7150.821229469305;7156.749513766993;7159.821004474826;7169.641517924083;6600.80197594073;6657.966710166418;6660.134182556237;6714.932850671528;6753;5964.284285885721;5982.252218472691;5983.910241346383;6061.060535616986;6065.120557519135;7448.292412220831;7478.401727861758;7510.549367037996;7538.623068846536;7546.698132074655;7011.053507776589;7099.325564071405;7181.245969173162;7206.135263768381;7207.531510451804;7267.454940879349;7314.37125748503;7410.777676669709;7429.5542267464125;7521.285477879593;6976.058232138799;6986.231514533296;7045.859082818418;7083.574985500886;7092.929070709433;7092.893606596009;7193.460490463341;7248;7248.746293879689;7285.7814265572115;6831.487638427038;6905.861882762216;6924.203716572659;6928.965355173192;7003;6815.761448349284;6857.7256909723055;6890.586564806128;6901.033855260167;6910.7581234658555;6827.93172068273;6832.795016149524;6902.378785909293;6912.205096413977;6923.099997000358;6936.514443988873;6936.618485983117;6963.199232088375;6983.231844497;7065.328793764585;6640.203175618956;6739.494537909578;6749.696263668245;6799.626020568719;6816.727330906709 05:51:41 INFO - PID 21534 | |1;ext.html;993.7018894331701;1014.5231741081689;1017.0846238385452;1018.3584341864624;1020.3367810922895;45783.77108114459;47567.52432475674;47590.28614570784;47636.523634763646;47649.52350476494;42867;43259.78370108145;43321;43334.7833260834;43375.34936975948;8112.837743245132;8227.218414250636;8245.13426090258;8269.338452923752;8271.33829293655;8107.635156417975;8193.303569196625;8203.671853125868;8208.302294304962;8209.466384685005;8205.917940820606;8725.7818554536;8870.15733505316;8942.687005954793;8947.64209431622;8735.039145693969;8771.868421973675;8808.119188081204;8853.601587928559;8858.86711699325;8699.956005279408;8752.824943501158;8795.384323097385;8799.516026618534;8809.64761409543;43513.56486435127;43535;43862.56137438617;43864.780676096416;43951;3775.2449510097817;3819.083419979213;3821.6560509554274;3821.7133714971487;3824.043989002749;35565.46651800225;35821.46267805985;35871.4619280711;35890.461643075374;35974.82012589947;5721.427857214287;5732.713364331767;5748.482636562688;5759.049756790125;5850.122481627747;228244;228491.8575407129;229557;229759;231076;48894.266586001235;49131.75434122878;53986.46013539893;54616.726916365165;54708.452915471134;57139.428605714245;57574.7121264391;57682;57749;57917.42082579205;18078.45764627063;18223.362182323555;18242.726359104625;18348.357807476674;18358.81641183598;15044.398224071134;15045.322960466805;15138;15288.617784555252;15302.387904483918;15131.243437828065;15375.461858835111;15388.846111538742;15404.922975385276;15526.146061966474;5795;5806.796762113306;5942.435468630473;5992.250968628921;5992.494390781441;1080.7244152741157;1100.5157730598512;1124.679466352102;1127.5264388956657;1138.6868611132004;26122;26238.86880565623;26361.604575931375;26428.207153785417;26434.735652643227;1227.7298994221258;1246.1090320420942;1249.4752204074312;1253.360785999147;1263.9368031598567;13844.93077534626;13947.093438926437;14041.297935103205;14253.714925701428;14340.282985850667;302216;303069;306930;307141;307422;60834.39165608287;60987.39012609817;61233.69383153145;61269.387306126366;61346.69326653338;1557.392616879418;1589.7059044076882;1592.0925072708676;1612.9112898790445;1615.8061032676153;25974.740252597232;26016.8699156503;26092;26322.86838565795;26441.471170576864;43457.565424345354;43459;43475.565244348414;43481;43498.782506087264;245778;246309;247936;248218;248330;38002.239955201294;43110;43744.343834841864;43864.34203486887;44081.338779918966;51744.74127629488;52849.735751321;53339.46660533345;53360.19959700685;53856.19215711846;39043.804780975915;39573.80213098916;39690.801545992086;39818.80090599528;40233;37745.24509509849;38734.612653874225;38777;38867.416988745754;39331.410028849015;44856.551434485234;45460.318095227936;45669;45985;46535.301970469794;38028.2394352117;38041;38091.23817523578;38152.809235953646;38672.41991370188;27264.773085210818;27961.881524738783;28249.293767655152;28378;28380.858095710217 05:51:41 INFO - PID 21534 | |2;jquery.html;641.7112299465239;641.9271535185934;654.4718083275551;657.1152639910789;657.5988646925375;24111;24884.253472395834;24920.252392428232;24923.127690530837;26186.345341366476;27917.581236281472;28522.857385713094;28524.572131418045;28525.28686782826;28578.42843143136;6376.107344971708;6956.6869490872905;6981.232064472904;7064.3288887555855;7082.752103676372;6967.407770339527;6988.825279368031;6991.82520436988;6993.335633114872;6995.02069710241;6965.79102626922;6968.581885086885;6977.162740471151;6980.232174460831;6985.161780586312;6915.930840691579;6920.273371296017;6961.6867240974025;6970.954356846463;6976.5116441849095;6561.2782593914635;6563.278039415661;6565.179352580927;6571.769988050443;6572.277049524549;30601;31155.844220778978;31470.37059258825;31519;31530.527042094385;2291.919782807594;2325.2907863101746;2336.1122773346187;2343.9765602343928;2347.272345572878;20324.187032518683;21295.574088518144;21302.680459793115;21307;21503.569928601497;2634.7628713415693;2702.2568793581727;2706.1205108339673;2710.2817753295394;2712.5795501697266;156226.21886890492;160715.19642401714;161144;161271;161680;16208.75686864698;17214.225359858836;17621.64756704859;17665.233476652233;17897;27646.585301220497;27739.44521109607;27810.443791124468;27828.44343113167;27846;11488.368139752227;11491.827622585668;11589.52314305705;11740.119491038206;11768.293902365886;9720.61117555304;9975.351602145838;10193.490325483845;10528.36829790215;10607.310524815863;9837.704868853945;10135.847962280424;10280.845787313196;10602.978151226864;10644.414557199274;2938.7795915306438;2946.808457450259;2971.22748085495;2982.537706655472;2992.5660779186896;1047.7747284333905;1061.4957894999968;1062.5324857062867;1068.513826209073;1072.9678109656722;21603.459913501974;22227.888860555595;22394.88802555977;22666;22672.319830405115;1113.8663360396804;1134.9546018159347;1150.815869460899;1153.3598852636699;1155.439611788282;11771.941140294415;12108.939455302667;12123.939380303042;12189.146759726911;12230.510779568896;660598;667859;677206;677646;696468;137051.31474342765;137255;137516.31241843727;137594.31202843922;141813;1145.7880292145812;1251.7121062155572;1270.3775150176348;1283.0697744135427;1285.7878450055637;19396.8060319395;19597.608047839247;19640;19660;19916.302929397403;63230.683846580476;64335.35664643481;64529;66489;66679.66660166669;82137;82695.7595636078;82981.17018829734;83376.7493487586;83769;15981.200939953189;16531.834681653512;16593.33689577806;16627.83372166311;16644.58388540296;24532.877335613208;24620;24663.50672986566;24782;24988.250352489453;18785.718214226523;18923.148458319683;19887.900560497106;20102.698459522828;20223.29218477346;15811.367545298059;16535.25591348368;16612.418565350155;16830.737694672705;18087.909560452114;20497.48756281105;20874.165033398494;20907.163713451293;20908.16367345289;21043.368698938444;16167.464090911344;16220.35118595243;16292.592685182964;16421.67156656884;16442.83557164413;19560;19589.020548972778;19593.510162246057;19682.704759428907;19694.507637309183 05:51:41 INFO - PID 21534 | |3;mootools.html;1455.7161353536062;1510.569487696007;1516.0827699241952;1534.631688394785;1537.2697968464981;17351.479455616336;17935;17943.192556334947;18043;18081.90959045203;17646.735298970525;17695.380661676845;17706.46880593581;17735.556611084696;17740;3044.467218236811;3074.892378766749;3107.4561951658484;3113.9844300778464;3116.158637167963;2999.9700002999907;3019.743321817648;3021.7884748067645;3027.2583217111837;3034.150437877398;2990.3421247325555;3024.8487575621243;3099.1942095055333;3103.2086817861414;3110.8289044102567;3076.9846150769104;3078.6921307869256;3079.9230019249476;3089.6755840636633;3116.5636810846386;2975.6577993530586;2988.0886329669443;3009.9398012039637;3011.8945836895605;3013.6835632258735;17057.317707291695;17360.826391736173;17382.826171738372;17407.56481087983;17429.21568529419;8780.121987801233;9028.954855225747;9036.45781253127;9048.864267036;9049.819003619956;5930.1401296812155;5968.224130863004;5972.880542389128;6038.547108966845;6045.909311360333;2116.354511873878;2150.9354719358444;2184.859858255371;2195.857269277508;2216.6785816056745;31553.36893262122;31556.684433155835;31773.682263177303;31782.523262151088;31783.84108079468;7464.664090115958;7577.318041376303;7628.427867909929;7848.450608457353;7862.803429914298;20882.164713411294;20884.269050583156;20893;21019.369418917457;21042.684359734616;8768.079351667982;8926.062763409878;8983.371164018456;8987.415817971942;8988.685396011108;8026.719064832703;8086.110527841933;8187.549684767276;8202.507849528927;8212.958935205286;5887.705614719247;6161.630302181794;6252.812415627538;6256.562040657111;6268.091126786681;1651.3229575873834;1671.1560661865924;1687.2744719770617;1726.896386216831;1755.9473215803546;1018.1142406106586;1024.4058446101244;1028.9125424339015;1041.338749893823;1043.0716662170673;9986.800263994679;10041.598336066476;10430.582776688847;10438.843417348746;10508.106810921005;1096.1450068946235;1096.8464414981909;1102.1898904305328;1104.779044191165;1121.2207515776456;6091.878162436727;6319.96840015797;6442.06590044441;6593.241777195684;6672.733090676318;25729.742702572734;26480.60279095815;26678.866605666848;26834.329141771614;27046;25247.24258272255;27252.182434526996;27439.45121097567;27513.31216719558;27607.30981725433;11711.648650540497;12284.324362160167;12377.566785162477;12490.75018499643;12534.686632834251;10094.949525252621;10171.186305095427;10200.438975856103;10292.485375731334;10439.634612788515;22154.55690886141;22344;22354.888225558767;22381.77618223797;22537.549249015257;23423.180188693314;23530.64704029407;23772.524549508566;23910.28269151928;24367.14714984967;13037.608871733863;13129.212247265195;13313;13335.933320333335;13372.732545349234;15187.392504299703;15277.618059548156;15340.693186136437;15346.616334591277;15368.923155384151;12216.572419965258;12303.323317217639;12516.31160286193;12545.435455404346;12769.297688627215;11565.942170289094;11724.413779311171;11795.174337796616;11819.290842549475;12135.271883687006;10560.313579617301;10728.624498142528;10762.354258744188;10836.783264334512;10845;7943.086545047394;7944.602769861368;7980.680772769024;7999.720009799629;8084;8338.29124524398;8459.534725590152;8553.95723021381;8565.400421970402;8599.656013759379 05:51:41 INFO - PID 21534 | |4;prototype.html;583.6731430398977;583.9620424672396;605.1920685884344;620.3455354600895;628.0453710360252;6330.240371155456;6368.586041907279;6404.551681382305;6412.326705695905;6417.294097649261;6251.906221406683;6286.3399343069;6327.1774669293045;6345.4923606111515;6349.650769207692;5264.921026184601;5276.287701160332;5296.496832800878;5301.416844147141;5315.787368505275;4990.500949905017;5153.304303918979;5221.765020574065;5270.235815806705;5275.36695596529;5056.393232812067;5116.283720279164;5141.922871156917;5143.151380022292;5156.226566015091;5050.974745126287;5086.135356989321;5104.719240441774;5135.666181698215;5156.097682905495;4649.1399091167905;4660.510646382115;4676.550269416492;4686.320483529869;4690.835820746292;6253.624782513064;6256.749730010794;6266.561340706153;6281.905771413432;6329.4619957303685;5935.584509084366;6061.939380606225;6073;6100.664463454508;6116.816495505142;6659.533832631718;6745.1905771307265;6790.197489405899;6800.251972283045;6815.15990682513;5017.623678224148;5232.267482552407;5247.1866860636665;5266.236395722637;5270.8155214567305;6972.2330543640155;6975.476839237078;7097.609631470267;7127.607981561064;7140.5001649884525;5370.8657283567445;5381.829082461124;5394.730263486888;5413.702246376409;5419.403865574784;5447.918281225785;5450.528357343495;5464.808731694451;5497.92790405875;5510.91733623996;5946.613470124428;6045.697715114226;6050.757969681252;6054.909176362358;6056.757729690763;6753.358430949052;6775.593464392152;6827.658617069127;6838.931610683929;6887.830333445049;1873.7751469823709;1879.6616609010237;1887.2356695538328;1896.662852688851;1900.5343690795844;1293.1012946002627;1336.2984433172662;1360.3062438156612;1361.1492816989382;1373.7527245095978;6228.408301211378;6278.686065696788;6333.828241775286;6377.64922929234;6446.7421303148285;6748;6789.355011273921;6832.965835170792;6847.589144651337;6869.931300687029;6350.4919606432295;6359.777407790705;6373.936260637334;6402.167718196604;6443.48452123829;3618.1316484044164;3621.9275614487565;3633.9818300908855;3656.305301992613;3658.7073034157734;7175.390091842252;7247.746328878464;7249.347558719741;7269.164046134656;7286.453515986323;6985.441164706811;7011.789646310619;7013.684384202723;7058.188308344606;7083.964580177066;7020.5787652741;7077.504574679826;7108.609026503592;7188.424926006011;7189.1373035235065;6730.528862979544;6755.392014718699;6780.38976492118;6785.389314961677;6868.793936181923;6801.591904485746;6803.693833777393;6827;6848.691808868513;6946.221511395483;7162.033125527987;7181.9586160005465;7194.172670143001;7212.4951253411755;7243.130824301117;5378.310844577712;5388.434214407587;5412.025835349675;5416.2688037114485;5430.049741295336;6588.637624930675;6704.832379190364;6803.557768745016;6838.897416538656;6909.723611055702;6295.370462953668;6564.540482166202;6611.933880661132;6645.269020407654;6697.296783837822;6534.901976470262;6664.333566643297;6680.131582894192;6687.264400915798;6698.66506674674;6521.706523206372;6558.508111891722;6646.169228846395;6646.767363142267;6663.7001334941015;6673.265940746417;6682.599044057372;6748.257691654012;6759.357861003196;6769.526133170828;6220.937790622217;6412.647304398303;6550.6069635822005;6565.474762018932;6577.539572229898 05:51:41 INFO - PID 21534 | |5;yui.html;987.9753006174849;1021.9744506387341;1036.6889933020097;1044.9268551201415;1056.4612047855592;19448.611027779454;20113;20163.294284700038;20163.495912602175;20169.59660806783;18154.727679084823;18432.447026589223;18635.720464193048;18999;19087.809121908776;1072.5763323487217;1089.6894385100247;1092.2354351953625;1092.5575142067476;1094;1068.2201992545447;1096.6545538155456;1105.4417519152817;1118.0440723181684;1119.2668801934706;1168.649405178443;1178.6169494914186;1178.770139822735;1181.2499063094954;1181.3384504677365;1173.7476442564846;1175.506287359311;1176.3001014396464;1176.805827038546;1177.375990724913;863.4215075899162;863.4387648028769;863.7581477186397;865.1089377940731;865.4071960706935;19802.60394792096;19817.702734458995;19975.400737977885;19989.70015449755;20008.79991200084;19921.701174482394;20108.49728756778;20535.589288214152;20544.897275513526;20551.794482055288;17986.55033624157;18068.36760713369;18193.545161371072;18225.362112326136;18261;3548.520949671787;3935.803209839525;3947.4868267125375;3950.920981580381;3953.940690889639;159446;159515;160241;160404;161088.19455902762;15918.76121858173;15956.840431595767;16094.839051609333;16096.597585060466;16141.59646008859;27253.182404527895;27438;27767.861160694472;27782.444351112863;28021.439571208462;9122.589483473259;9153.17621414076;9167.083291670913;9171.266298696088;9174.082591740906;4783.736894470838;4830.227163653799;4833.299171620095;4843.564079232886;4852.1508735971065;5877.706114694333;6110.480609148183;6141.385861413913;6159.4456498915315;6184.721687523982;1140.749035212252;1171.7305019845483;1181.3974872814754;1189.042820529482;1193.0634451955173;714.8141483214401;728.8578727148155;731.7438896386222;748.1770052941721;753.5441058159844;11323.584551931008;11802.5869094583;12179.573714919936;12575;12704.936475317749;692.2765709833136;692.5498426023024;698.9196242432083;703.0649236515422;718.5437247347971;5541.861453463695;5626.156076588544;5669.2346533218315;5780.364159942403;5825.1844741736195;146497;148438;149185;151298;151956;128690;135387.32306338602;136524;136874;138165;115777;116760.41619791847;117907;119091.40454297846;120280.3985980082;10726.302790318605;10898.727531811768;11048.723781905517;11100;11170.832437513607;58027;58108.41891581199;58424.415755841896;59620;60079.39920600738;73945.63027184829;74155;74506;76338;76471.61764191143;15850.682986339978;16138;16158.596035098746;16159.272832722321;16177.191140443167;17003.91498042502;17092.572685682957;17169;17298.308067677655;17314.480565582548;16248;16528.504144875675;16568.502944911674;16654.66690666204;16658.083805390335;16274.837251627332;16367.427140050517;16524.173791310626;16553.420630277884;16689.74965375496;16193;16233;16244.269007894909;16399.91800040992;16476.67046659036;11471.197016209118;11482.36846973391;11610.187286889837;11624.837516248308;11820.349880756641;11628.94185529067;11671.474783634927;11719.238249513754;11744.942955134078;12003.699907502032 05:51:41 INFO - PID 21534 | __end_tp_report 05:51:41 INFO - PID 21534 | __start_cc_report 05:51:41 INFO - PID 21534 | _x_x_mozilla_cycle_collect,258 05:51:41 INFO - PID 21534 | __end_cc_report 05:51:41 INFO - PID 21534 | __startTimestamp1506948701672__endTimestamp 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | ------- Summary: start ------- 05:51:41 INFO - PID 21534 | Number of tests: 6 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#0] dojo.html Cycles:165 Average:6604.57 Median:6827.93 stddev:760.28 (11.1%) stddev-sans-first:735.23 05:51:41 INFO - PID 21534 | Values: 4027.0 4037.8 4049.8 4060.5 4067.8 6458.9 6568.5 6637.2 6669.0 6678.3 6539.3 6579.7 6608.7 6661.5 6665.9 5912.5 5931.6 5959.8 5969.2 6008.1 5880.3 5982.5 5990.5 6058.2 6063.6 5943.0 5970.6 5973.1 5986.3 6003.5 5916.3 6009.0 6062.0 6065.7 6067.4 5884.7 5957.7 5977.8 5981.0 6057.3 6464.7 6520.8 6529.4 6532.6 6559.4 7089.0 7189.1 7195.2 7205.1 7207.2 7130.5 7131.9 7151.1 7172.1 7225.6 6442.3 6697.8 6698.6 6699.8 6701.1 7282.3 7376.4 7378.8 7394.2 7399.5 7066.3 7078.3 7147.8 7160.0 7167.6 7198.2 7206.8 7288.5 7294.9 7308.5 6998.9 7076.4 7088.3 7160.1 7231.9 6748.8 7094.8 7106.5 7122.5 7124.7 5304.5 5377.2 5377.6 5378.7 5382.4 4789.0 4793.4 4832.1 4863.3 4867.6 6560.7 6598.3 6682.1 6714.1 6714.1 7049.0 7150.8 7156.7 7159.8 7169.6 6600.8 6658.0 6660.1 6714.9 6753.0 5964.3 5982.3 5983.9 6061.1 6065.1 7448.3 7478.4 7510.5 7538.6 7546.7 7011.1 7099.3 7181.2 7206.1 7207.5 7267.5 7314.4 7410.8 7429.6 7521.3 6976.1 6986.2 7045.9 7083.6 7092.9 7092.9 7193.5 7248.0 7248.7 7285.8 6831.5 6905.9 6924.2 6929.0 7003.0 6815.8 6857.7 6890.6 6901.0 6910.8 6827.9 6832.8 6902.4 6912.2 6923.1 6936.5 6936.6 6963.2 6983.2 7065.3 6640.2 6739.5 6749.7 6799.6 6816.7 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#1] ext.html Cycles:180 Average:45307.12 Median:39452.61 stddev:68299.54 (173.1%) stddev-sans-first:68410.09 05:51:41 INFO - PID 21534 | Values: 993.7 1014.5 1017.1 1018.4 1020.3 45783.8 47567.5 47590.3 47636.5 47649.5 42867.0 43259.8 43321.0 43334.8 43375.3 8112.8 8227.2 8245.1 8269.3 8271.3 8107.6 8193.3 8203.7 8208.3 8209.5 8205.9 8725.8 8870.2 8942.7 8947.6 8735.0 8771.9 8808.1 8853.6 8858.9 8700.0 8752.8 8795.4 8799.5 8809.6 43513.6 43535.0 43862.6 43864.8 43951.0 3775.2 3819.1 3821.7 3821.7 3824.0 35565.5 35821.5 35871.5 35890.5 35974.8 5721.4 5732.7 5748.5 5759.0 5850.1 228244.0 228491.9 229557.0 229759.0 231076.0 48894.3 49131.8 53986.5 54616.7 54708.5 57139.4 57574.7 57682.0 57749.0 57917.4 18078.5 18223.4 18242.7 18348.4 18358.8 15044.4 15045.3 15138.0 15288.6 15302.4 15131.2 15375.5 15388.8 15404.9 15526.1 5795.0 5806.8 5942.4 5992.3 5992.5 1080.7 1100.5 1124.7 1127.5 1138.7 26122.0 26238.9 26361.6 26428.2 26434.7 1227.7 1246.1 1249.5 1253.4 1263.9 13844.9 13947.1 14041.3 14253.7 14340.3 302216.0 303069.0 306930.0 307141.0 307422.0 60834.4 60987.4 61233.7 61269.4 61346.7 1557.4 1589.7 1592.1 1612.9 1615.8 25974.7 26016.9 26092.0 26322.9 26441.5 43457.6 43459.0 43475.6 43481.0 43498.8 245778.0 246309.0 247936.0 248218.0 248330.0 38002.2 43110.0 43744.3 43864.3 44081.3 51744.7 52849.7 53339.5 53360.2 53856.2 39043.8 39573.8 39690.8 39818.8 40233.0 37745.2 38734.6 38777.0 38867.4 39331.4 44856.6 45460.3 45669.0 45985.0 46535.3 38028.2 38041.0 38091.2 38152.8 38672.4 27264.8 27961.9 28249.3 28378.0 28380.9 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#2] jquery.html Cycles:180 Average:42786.78 Median:22669.16 stddev:112769.07 (497.5%) stddev-sans-first:113041.02 05:51:41 INFO - PID 21534 | Values: 641.7 641.9 654.5 657.1 657.6 24111.0 24884.3 24920.3 24923.1 26186.3 27917.6 28522.9 28524.6 28525.3 28578.4 6376.1 6956.7 6981.2 7064.3 7082.8 6967.4 6988.8 6991.8 6993.3 6995.0 6965.8 6968.6 6977.2 6980.2 6985.2 6915.9 6920.3 6961.7 6971.0 6976.5 6561.3 6563.3 6565.2 6571.8 6572.3 30601.0 31155.8 31470.4 31519.0 31530.5 2291.9 2325.3 2336.1 2344.0 2347.3 20324.2 21295.6 21302.7 21307.0 21503.6 2634.8 2702.3 2706.1 2710.3 2712.6 156226.2 160715.2 161144.0 161271.0 161680.0 16208.8 17214.2 17621.6 17665.2 17897.0 27646.6 27739.4 27810.4 27828.4 27846.0 11488.4 11491.8 11589.5 11740.1 11768.3 9720.6 9975.4 10193.5 10528.4 10607.3 9837.7 10135.8 10280.8 10603.0 10644.4 2938.8 2946.8 2971.2 2982.5 2992.6 1047.8 1061.5 1062.5 1068.5 1073.0 21603.5 22227.9 22394.9 22666.0 22672.3 1113.9 1135.0 1150.8 1153.4 1155.4 11771.9 12108.9 12123.9 12189.1 12230.5 660598.0 667859.0 677206.0 677646.0 696468.0 137051.3 137255.0 137516.3 137594.3 141813.0 1145.8 1251.7 1270.4 1283.1 1285.8 19396.8 19597.6 19640.0 19660.0 19916.3 63230.7 64335.4 64529.0 66489.0 66679.7 82137.0 82695.8 82981.2 83376.7 83769.0 15981.2 16531.8 16593.3 16627.8 16644.6 24532.9 24620.0 24663.5 24782.0 24988.3 18785.7 18923.1 19887.9 20102.7 20223.3 15811.4 16535.3 16612.4 16830.7 18087.9 20497.5 20874.2 20907.2 20908.2 21043.4 16167.5 16220.4 16292.6 16421.7 16442.8 19560.0 19589.0 19593.5 19682.7 19694.5 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#3] mootools.html Cycles:180 Average:10922.87 Median:23651.59 stddev:8120.23 (34.3%) stddev-sans-first:8111.85 05:51:41 INFO - PID 21534 | Values: 1455.7 1510.6 1516.1 1534.6 1537.3 17351.5 17935.0 17943.2 18043.0 18081.9 17646.7 17695.4 17706.5 17735.6 17740.0 3044.5 3074.9 3107.5 3114.0 3116.2 3000.0 3019.7 3021.8 3027.3 3034.2 2990.3 3024.8 3099.2 3103.2 3110.8 3077.0 3078.7 3079.9 3089.7 3116.6 2975.7 2988.1 3009.9 3011.9 3013.7 17057.3 17360.8 17382.8 17407.6 17429.2 8780.1 9029.0 9036.5 9048.9 9049.8 5930.1 5968.2 5972.9 6038.5 6045.9 2116.4 2150.9 2184.9 2195.9 2216.7 31553.4 31556.7 31773.7 31782.5 31783.8 7464.7 7577.3 7628.4 7848.5 7862.8 20882.2 20884.3 20893.0 21019.4 21042.7 8768.1 8926.1 8983.4 8987.4 8988.7 8026.7 8086.1 8187.5 8202.5 8213.0 5887.7 6161.6 6252.8 6256.6 6268.1 1651.3 1671.2 1687.3 1726.9 1755.9 1018.1 1024.4 1028.9 1041.3 1043.1 9986.8 10041.6 10430.6 10438.8 10508.1 1096.1 1096.8 1102.2 1104.8 1121.2 6091.9 6320.0 6442.1 6593.2 6672.7 25729.7 26480.6 26678.9 26834.3 27046.0 25247.2 27252.2 27439.5 27513.3 27607.3 11711.6 12284.3 12377.6 12490.8 12534.7 10094.9 10171.2 10200.4 10292.5 10439.6 22154.6 22344.0 22354.9 22381.8 22537.5 23423.2 23530.6 23772.5 23910.3 24367.1 13037.6 13129.2 13313.0 13335.9 13372.7 15187.4 15277.6 15340.7 15346.6 15368.9 12216.6 12303.3 12516.3 12545.4 12769.3 11565.9 11724.4 11795.2 11819.3 12135.3 10560.3 10728.6 10762.4 10836.8 10845.0 7943.1 7944.6 7980.7 7999.7 8084.0 8338.3 8459.5 8554.0 8565.4 8599.7 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#4] prototype.html Cycles:180 Average:5766.14 Median:6350.07 stddev:1587.91 (25.0%) stddev-sans-first:1543.99 05:51:41 INFO - PID 21534 | Values: 583.7 584.0 605.2 620.3 628.0 6330.2 6368.6 6404.6 6412.3 6417.3 6251.9 6286.3 6327.2 6345.5 6349.7 5264.9 5276.3 5296.5 5301.4 5315.8 4990.5 5153.3 5221.8 5270.2 5275.4 5056.4 5116.3 5141.9 5143.2 5156.2 5051.0 5086.1 5104.7 5135.7 5156.1 4649.1 4660.5 4676.6 4686.3 4690.8 6253.6 6256.7 6266.6 6281.9 6329.5 5935.6 6061.9 6073.0 6100.7 6116.8 6659.5 6745.2 6790.2 6800.3 6815.2 5017.6 5232.3 5247.2 5266.2 5270.8 6972.2 6975.5 7097.6 7127.6 7140.5 5370.9 5381.8 5394.7 5413.7 5419.4 5447.9 5450.5 5464.8 5497.9 5510.9 5946.6 6045.7 6050.8 6054.9 6056.8 6753.4 6775.6 6827.7 6838.9 6887.8 1873.8 1879.7 1887.2 1896.7 1900.5 1293.1 1336.3 1360.3 1361.1 1373.8 6228.4 6278.7 6333.8 6377.6 6446.7 6748.0 6789.4 6833.0 6847.6 6869.9 6350.5 6359.8 6373.9 6402.2 6443.5 3618.1 3621.9 3634.0 3656.3 3658.7 7175.4 7247.7 7249.3 7269.2 7286.5 6985.4 7011.8 7013.7 7058.2 7084.0 7020.6 7077.5 7108.6 7188.4 7189.1 6730.5 6755.4 6780.4 6785.4 6868.8 6801.6 6803.7 6827.0 6848.7 6946.2 7162.0 7182.0 7194.2 7212.5 7243.1 5378.3 5388.4 5412.0 5416.3 5430.0 6588.6 6704.8 6803.6 6838.9 6909.7 6295.4 6564.5 6611.9 6645.3 6697.3 6534.9 6664.3 6680.1 6687.3 6698.7 6521.7 6558.5 6646.2 6646.8 6663.7 6673.3 6682.6 6748.3 6759.4 6769.5 6220.9 6412.6 6550.6 6565.5 6577.5 05:51:41 INFO - PID 21534 | 05:51:41 INFO - PID 21534 | [#5] yui.html Cycles:180 Average:27920.80 Median:16611.58 stddev:43013.54 (258.9%) stddev-sans-first:43086.67 05:51:41 INFO - PID 21534 | Values: 988.0 1022.0 1036.7 1044.9 1056.5 19448.6 20113.0 20163.3 20163.5 20169.6 18154.7 18432.4 18635.7 18999.0 19087.8 1072.6 1089.7 1092.2 1092.6 1094.0 1068.2 1096.7 1105.4 1118.0 1119.3 1168.6 1178.6 1178.8 1181.2 1181.3 1173.7 1175.5 1176.3 1176.8 1177.4 863.4 863.4 863.8 865.1 865.4 19802.6 19817.7 19975.4 19989.7 20008.8 19921.7 20108.5 20535.6 20544.9 20551.8 17986.6 18068.4 18193.5 18225.4 18261.0 3548.5 3935.8 3947.5 3950.9 3953.9 159446.0 159515.0 160241.0 160404.0 161088.2 15918.8 15956.8 16094.8 16096.6 16141.6 27253.2 27438.0 27767.9 27782.4 28021.4 9122.6 9153.2 9167.1 9171.3 9174.1 4783.7 4830.2 4833.3 4843.6 4852.2 5877.7 6110.5 6141.4 6159.4 6184.7 1140.7 1171.7 1181.4 1189.0 1193.1 714.8 728.9 731.7 748.2 753.5 11323.6 11802.6 12179.6 12575.0 12704.9 692.3 692.5 698.9 703.1 718.5 5541.9 5626.2 5669.2 5780.4 5825.2 146497.0 148438.0 149185.0 151298.0 151956.0 128690.0 135387.3 136524.0 136874.0 138165.0 115777.0 116760.4 117907.0 119091.4 120280.4 10726.3 10898.7 11048.7 11100.0 11170.8 58027.0 58108.4 58424.4 59620.0 60079.4 73945.6 74155.0 74506.0 76338.0 76471.6 15850.7 16138.0 16158.6 16159.3 16177.2 17003.9 17092.6 17169.0 17298.3 17314.5 16248.0 16528.5 16568.5 16654.7 16658.1 16274.8 16367.4 16524.2 16553.4 16689.7 16193.0 16233.0 16244.3 16399.9 16476.7 11471.2 11482.4 11610.2 11624.8 11820.3 11628.9 11671.5 11719.2 11744.9 12003.7 05:51:41 INFO - PID 21534 | -------- Summary: end -------- 05:51:41 INFO - PID 21534 | 05:51:42 INFO - TEST-INFO | 21534: exit 0 05:51:42 INFO - TEST-OK | dromaeo_css | took 1106958ms 05:51:42 INFO - TEST-START | kraken 05:51:42 INFO - Initialising browser for kraken test... 05:51:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37572/getInfo.html -profile /tmp/tmpx3eSHw/profile 05:51:42 INFO - TEST-INFO | started process 21896 (/builds/slave/test/build/application/firefox/firefox http://localhost:37572/getInfo.html) 05:51:47 INFO - TEST-INFO | 21896: exit 0 05:51:47 INFO - Browser initialized. 05:51:47 INFO - Running cycle 1/1 for kraken test... 05:51:47 INFO - Using env: {'DISPLAY': ':0', 05:51:47 INFO - 'HOME': '/home/cltbld', 05:51:47 INFO - 'JSGC_DISABLE_POISONING': '1', 05:51:47 INFO - 'LANG': 'en_US.UTF-8', 05:51:47 INFO - 'LANGUAGE': 'en_US:en', 05:51:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:51:47 INFO - 'LOGNAME': 'cltbld', 05:51:47 INFO - 'MAIL': '/var/mail/cltbld', 05:51:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:47 INFO - 'MOZ_CRASHREPORTER': '1', 05:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:51:47 INFO - 'MOZ_NO_REMOTE': '1', 05:51:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:47 INFO - 'NO_EM_RESTART': '1', 05:51:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:47 INFO - 'PWD': '/builds/slave/test', 05:51:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:47 INFO - 'RUST_BACKTRACE': 'full', 05:51:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:51:47 INFO - 'SHELL': '/bin/bash', 05:51:47 INFO - 'SHLVL': '1', 05:51:47 INFO - 'TERM': 'linux', 05:51:47 INFO - 'TMOUT': '86400', 05:51:47 INFO - 'USER': 'cltbld', 05:51:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134', 05:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:47 INFO - '_': '/tools/buildbot/bin/python'} 05:51:47 INFO - TEST-INFO | started process 22081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx3eSHw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:47 INFO - PID 22081 | 05:51:47 INFO - PID 22081 | (/builds/slave/test/build/application/firefox/firefox:22130): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:51:47 INFO - PID 22081 | 05:51:58 INFO - PID 22081 | RSS: Main: 143159296 05:51:58 INFO - PID 22081 | 05:52:00 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37572/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:01 INFO - PID 22081 | RSS: Main: 149110784 05:52:01 INFO - PID 22081 | 05:52:04 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37572/tests/kraken/driver.html?testName=audio-dft) 05:52:04 INFO - PID 22081 | RSS: Main: 149995520 05:52:04 INFO - PID 22081 | 05:52:07 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37572/tests/kraken/driver.html?testName=audio-fft) 05:52:08 INFO - PID 22081 | RSS: Main: 151052288 05:52:08 INFO - PID 22081 | 05:52:10 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37572/tests/kraken/driver.html?testName=audio-oscillator) 05:52:10 INFO - PID 22081 | RSS: Main: 150847488 05:52:10 INFO - PID 22081 | 05:52:12 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:13 INFO - PID 22081 | RSS: Main: 150806528 05:52:13 INFO - PID 22081 | 05:52:16 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37572/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:17 INFO - PID 22081 | RSS: Main: 151179264 05:52:17 INFO - PID 22081 | 05:52:20 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37572/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:21 INFO - PID 22081 | RSS: Main: 151572480 05:52:21 INFO - PID 22081 | 05:52:24 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37572/tests/kraken/driver.html?testName=json-parse-financial) 05:52:24 INFO - PID 22081 | RSS: Main: 153673728 05:52:24 INFO - PID 22081 | 05:52:26 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:26 INFO - PID 22081 | RSS: Main: 153034752 05:52:26 INFO - PID 22081 | 05:52:28 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:28 INFO - PID 22081 | RSS: Main: 153088000 05:52:28 INFO - PID 22081 | 05:52:30 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:31 INFO - PID 22081 | RSS: Main: 149782528 05:52:31 INFO - PID 22081 | 05:52:33 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:34 INFO - PID 22081 | RSS: Main: 149471232 05:52:34 INFO - PID 22081 | 05:52:37 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:37 INFO - PID 22081 | RSS: Main: 150122496 05:52:37 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | Cycle 1(1): loaded http://localhost:37572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37572/tests/kraken/driver.html?testName=ai-astar) 05:52:39 INFO - PID 22081 | RSS: Main: 151912448 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | __start_tp_report 05:52:39 INFO - PID 22081 | _x_x_mozilla_page_load 05:52:39 INFO - PID 22081 | _x_x_mozilla_page_load_details 05:52:39 INFO - PID 22081 | |i|pagename|runs| 05:52:39 INFO - PID 22081 | |0;ai-astar;106;108;104;104;106;107;96;105;106;105 05:52:39 INFO - PID 22081 | |1;audio-beat-detection;112;112;112;113;109;110;114;109;110;110 05:52:39 INFO - PID 22081 | |2;audio-dft;164;163;162;163;163;163;161;162;163;165 05:52:39 INFO - PID 22081 | |3;audio-fft;72;73;76;74;74;73;74;72;73;74 05:52:39 INFO - PID 22081 | |4;audio-oscillator;78;77;77;77;84;77;77;77;77;78 05:52:39 INFO - PID 22081 | |5;imaging-gaussian-blur;110;113;109;113;113;110;113;111;113;110 05:52:39 INFO - PID 22081 | |6;imaging-darkroom;148;148;148;149;148;148;149;149;150;151 05:52:39 INFO - PID 22081 | |7;imaging-desaturate;94;93;94;94;94;95;94;99;94;94 05:52:39 INFO - PID 22081 | |8;json-parse-financial;44;44;44;46;49;52;44;44;44;44 05:52:39 INFO - PID 22081 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 05:52:39 INFO - PID 22081 | |10;stanford-crypto-aes;77;68;70;68;69;68;70;69;69;74 05:52:39 INFO - PID 22081 | |11;stanford-crypto-ccm;103;103;98;101;103;101;106;103;100;109 05:52:39 INFO - PID 22081 | |12;stanford-crypto-pbkdf2;150;154;145;162;153;147;160;150;148;152 05:52:39 INFO - PID 22081 | |13;stanford-crypto-sha256-iterative;60;58;59;57;57;57;58;58;56;60 05:52:39 INFO - PID 22081 | __end_tp_report 05:52:39 INFO - PID 22081 | __start_cc_report 05:52:39 INFO - PID 22081 | _x_x_mozilla_cycle_collect,667 05:52:39 INFO - PID 22081 | __end_cc_report 05:52:39 INFO - PID 22081 | __startTimestamp1506948759646__endTimestamp 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | ------- Summary: start ------- 05:52:39 INFO - PID 22081 | Number of tests: 14 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#0] ai-astar Cycles:10 Average:104.70 Median:106.00 stddev:3.30 (3.1%) stddev-sans-first:3.47 05:52:39 INFO - PID 22081 | Values: 106.0 108.0 104.0 104.0 106.0 107.0 96.0 105.0 106.0 105.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#1] audio-beat-detection Cycles:10 Average:111.10 Median:112.00 stddev:1.73 (1.5%) stddev-sans-first:1.80 05:52:39 INFO - PID 22081 | Values: 112.0 112.0 112.0 113.0 109.0 110.0 114.0 109.0 110.0 110.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 05:52:39 INFO - PID 22081 | Values: 164.0 163.0 162.0 163.0 163.0 163.0 161.0 162.0 163.0 165.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#3] audio-fft Cycles:10 Average:73.50 Median:74.00 stddev:1.18 (1.6%) stddev-sans-first:1.12 05:52:39 INFO - PID 22081 | Values: 72.0 73.0 76.0 74.0 74.0 73.0 74.0 72.0 73.0 74.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:77.00 stddev:2.18 (2.8%) stddev-sans-first:2.32 05:52:39 INFO - PID 22081 | Values: 78.0 77.0 77.0 77.0 84.0 77.0 77.0 77.0 77.0 78.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#5] imaging-gaussian-blur Cycles:10 Average:111.50 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.66 05:52:39 INFO - PID 22081 | Values: 110.0 113.0 109.0 113.0 113.0 110.0 113.0 111.0 113.0 110.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 05:52:39 INFO - PID 22081 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 149.0 149.0 150.0 151.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 05:52:39 INFO - PID 22081 | Values: 94.0 93.0 94.0 94.0 94.0 95.0 94.0 99.0 94.0 94.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#8] json-parse-financial Cycles:10 Average:45.50 Median:44.00 stddev:2.80 (6.4%) stddev-sans-first:2.92 05:52:39 INFO - PID 22081 | Values: 44.0 44.0 44.0 46.0 49.0 52.0 44.0 44.0 44.0 44.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:52:39 INFO - PID 22081 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#10] stanford-crypto-aes Cycles:10 Average:70.20 Median:69.50 stddev:2.97 (4.3%) stddev-sans-first:1.88 05:52:39 INFO - PID 22081 | Values: 77.0 68.0 70.0 68.0 69.0 68.0 70.0 69.0 69.0 74.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#11] stanford-crypto-ccm Cycles:10 Average:102.70 Median:103.00 stddev:3.09 (3.0%) stddev-sans-first:3.28 05:52:39 INFO - PID 22081 | Values: 103.0 103.0 98.0 101.0 103.0 101.0 106.0 103.0 100.0 109.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:152.50 stddev:5.45 (3.6%) stddev-sans-first:5.72 05:52:39 INFO - PID 22081 | Values: 150.0 154.0 145.0 162.0 153.0 147.0 160.0 150.0 148.0 152.0 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.00 Median:58.00 stddev:1.33 (2.3%) stddev-sans-first:1.20 05:52:39 INFO - PID 22081 | Values: 60.0 58.0 59.0 57.0 57.0 57.0 58.0 58.0 56.0 60.0 05:52:39 INFO - PID 22081 | -------- Summary: end -------- 05:52:39 INFO - PID 22081 | 05:52:39 INFO - PID 22081 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:52:40 INFO - TEST-INFO | 22081: exit 0 05:52:40 INFO - TEST-OK | kraken | took 57950ms 05:52:40 INFO - SUITE-END | took 1164s 05:52:40 INFO - Completed test suite (00:19:24) 05:52:40 INFO - javascript benchmark 05:52:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9369.703344817182, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4026.9798651006745, 4037.777922214279, 4049.838006479741, 4060.4518390017356, 4067.816948237331, 6458.935410645892, 6568.507361947861, 6637.236717777457, 6668.966655166723, 6678.265390807013, 6539.346065393458, 6579.736810527573, 6608.669566521667, 6661.4670826333895, 6665.900011499819, 5912.497437717778, 5931.614445061057, 5959.761609535635, 5969.224000879891, 6008.098785182214, 5880.323762767293, 5982.46157845796, 5990.460858522732, 6058.1518587397795, 6063.575549711522, 5943.0, 5970.641761494303, 5973.074173503114, 5986.311574168961, 6003.489703375197, 5916.26046744157, 6009.0, 6061.969690151565, 6065.696715164224, 6067.393260673919, 5884.705764711747, 5957.731902064417, 5977.820665380045, 5981.043033114681, 6057.30341010785, 6464.709088091047, 6520.804375868732, 6529.412352888263, 6532.5753826001155, 6559.376859198369, 7089.0, 7189.1013623297085, 7195.208527062019, 7205.099362579677, 7207.207207207203, 7130.5365151265005, 7131.89302160468, 7151.141862976424, 7172.0676312079095, 7225.602591857446, 6442.323556026597, 6697.799066027978, 6698.56459330142, 6699.832504187337, 6701.09535212745, 7282.3145908458555, 7376.373008294355, 7378.815529611803, 7394.186639469654, 7399.48203625741, 7066.293370662893, 7078.25678303781, 7147.82130446743, 7160.0, 7167.605781682058, 7198.208197098315, 7206.819829504199, 7288.489805713549, 7294.854102917912, 7308.488405811649, 6998.930010699828, 7076.363127318463, 7088.291170882973, 7160.10498687664, 7231.89152162718, 6748.83127921796, 7094.751683691046, 7106.467014973794, 7122.501424900311, 7124.679389427488, 5304.496072873071, 5377.166539186433, 5377.623566350318, 5378.73106344689, 5382.3541175059245, 4788.952110478851, 4793.376861008047, 4832.130216561053, 4863.294822250825, 4867.634927380461, 6560.737570497222, 6598.3401659833635, 6682.064510968468, 6714.060031595581, 6714.1271634688155, 7048.964755176191, 7150.821229469305, 7156.749513766993, 7159.821004474826, 7169.641517924083, 6600.80197594073, 6657.966710166418, 6660.134182556237, 6714.932850671528, 6753.0, 5964.284285885721, 5982.252218472691, 5983.910241346383, 6061.060535616986, 6065.120557519135, 7448.292412220831, 7478.401727861758, 7510.549367037996, 7538.623068846536, 7546.698132074655, 7011.053507776589, 7099.325564071405, 7181.245969173162, 7206.135263768381, 7207.531510451804, 7267.454940879349, 7314.37125748503, 7410.777676669709, 7429.5542267464125, 7521.285477879593, 6976.058232138799, 6986.231514533296, 7045.859082818418, 7083.574985500886, 7092.929070709433, 7092.893606596009, 7193.460490463341, 7248.0, 7248.746293879689, 7285.7814265572115, 6831.487638427038, 6905.861882762216, 6924.203716572659, 6928.965355173192, 7003.0, 6815.761448349284, 6857.7256909723055, 6890.586564806128, 6901.033855260167, 6910.7581234658555, 6827.93172068273, 6832.795016149524, 6902.378785909293, 6912.205096413977, 6923.099997000358, 6936.514443988873, 6936.618485983117, 6963.199232088375, 6983.231844497, 7065.328793764585, 6640.203175618956, 6739.494537909578, 6749.696263668245, 6799.626020568719, 6816.727330906709], "value": 6554.268102641295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [993.7018894331701, 1014.5231741081689, 1017.0846238385452, 1018.3584341864624, 1020.3367810922895, 45783.77108114459, 47567.52432475674, 47590.28614570784, 47636.523634763646, 47649.52350476494, 42867.0, 43259.78370108145, 43321.0, 43334.7833260834, 43375.34936975948, 8112.837743245132, 8227.218414250636, 8245.13426090258, 8269.338452923752, 8271.33829293655, 8107.635156417975, 8193.303569196625, 8203.671853125868, 8208.302294304962, 8209.466384685005, 8205.917940820606, 8725.7818554536, 8870.15733505316, 8942.687005954793, 8947.64209431622, 8735.039145693969, 8771.868421973675, 8808.119188081204, 8853.601587928559, 8858.86711699325, 8699.956005279408, 8752.824943501158, 8795.384323097385, 8799.516026618534, 8809.64761409543, 43513.56486435127, 43535.0, 43862.56137438617, 43864.780676096416, 43951.0, 3775.2449510097817, 3819.083419979213, 3821.6560509554274, 3821.7133714971487, 3824.043989002749, 35565.46651800225, 35821.46267805985, 35871.4619280711, 35890.461643075374, 35974.82012589947, 5721.427857214287, 5732.713364331767, 5748.482636562688, 5759.049756790125, 5850.122481627747, 228244.0, 228491.8575407129, 229557.0, 229759.0, 231076.0, 48894.266586001235, 49131.75434122878, 53986.46013539893, 54616.726916365165, 54708.452915471134, 57139.428605714245, 57574.7121264391, 57682.0, 57749.0, 57917.42082579205, 18078.45764627063, 18223.362182323555, 18242.726359104625, 18348.357807476674, 18358.81641183598, 15044.398224071134, 15045.322960466805, 15138.0, 15288.617784555252, 15302.387904483918, 15131.243437828065, 15375.461858835111, 15388.846111538742, 15404.922975385276, 15526.146061966474, 5795.0, 5806.796762113306, 5942.435468630473, 5992.250968628921, 5992.494390781441, 1080.7244152741157, 1100.5157730598512, 1124.679466352102, 1127.5264388956657, 1138.6868611132004, 26122.0, 26238.86880565623, 26361.604575931375, 26428.207153785417, 26434.735652643227, 1227.7298994221258, 1246.1090320420942, 1249.4752204074312, 1253.360785999147, 1263.9368031598567, 13844.93077534626, 13947.093438926437, 14041.297935103205, 14253.714925701428, 14340.282985850667, 302216.0, 303069.0, 306930.0, 307141.0, 307422.0, 60834.39165608287, 60987.39012609817, 61233.69383153145, 61269.387306126366, 61346.69326653338, 1557.392616879418, 1589.7059044076882, 1592.0925072708676, 1612.9112898790445, 1615.8061032676153, 25974.740252597232, 26016.8699156503, 26092.0, 26322.86838565795, 26441.471170576864, 43457.565424345354, 43459.0, 43475.565244348414, 43481.0, 43498.782506087264, 245778.0, 246309.0, 247936.0, 248218.0, 248330.0, 38002.239955201294, 43110.0, 43744.343834841864, 43864.34203486887, 44081.338779918966, 51744.74127629488, 52849.735751321, 53339.46660533345, 53360.19959700685, 53856.19215711846, 39043.804780975915, 39573.80213098916, 39690.801545992086, 39818.80090599528, 40233.0, 37745.24509509849, 38734.612653874225, 38777.0, 38867.416988745754, 39331.410028849015, 44856.551434485234, 45460.318095227936, 45669.0, 45985.0, 46535.301970469794, 38028.2394352117, 38041.0, 38091.23817523578, 38152.809235953646, 38672.41991370188, 27264.773085210818, 27961.881524738783, 28249.293767655152, 28378.0, 28380.858095710217], "value": 19718.26475421372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.7112299465239, 641.9271535185934, 654.4718083275551, 657.1152639910789, 657.5988646925375, 24111.0, 24884.253472395834, 24920.252392428232, 24923.127690530837, 26186.345341366476, 27917.581236281472, 28522.857385713094, 28524.572131418045, 28525.28686782826, 28578.42843143136, 6376.107344971708, 6956.6869490872905, 6981.232064472904, 7064.3288887555855, 7082.752103676372, 6967.407770339527, 6988.825279368031, 6991.82520436988, 6993.335633114872, 6995.02069710241, 6965.79102626922, 6968.581885086885, 6977.162740471151, 6980.232174460831, 6985.161780586312, 6915.930840691579, 6920.273371296017, 6961.6867240974025, 6970.954356846463, 6976.5116441849095, 6561.2782593914635, 6563.278039415661, 6565.179352580927, 6571.769988050443, 6572.277049524549, 30601.0, 31155.844220778978, 31470.37059258825, 31519.0, 31530.527042094385, 2291.919782807594, 2325.2907863101746, 2336.1122773346187, 2343.9765602343928, 2347.272345572878, 20324.187032518683, 21295.574088518144, 21302.680459793115, 21307.0, 21503.569928601497, 2634.7628713415693, 2702.2568793581727, 2706.1205108339673, 2710.2817753295394, 2712.5795501697266, 156226.21886890492, 160715.19642401714, 161144.0, 161271.0, 161680.0, 16208.75686864698, 17214.225359858836, 17621.64756704859, 17665.233476652233, 17897.0, 27646.585301220497, 27739.44521109607, 27810.443791124468, 27828.44343113167, 27846.0, 11488.368139752227, 11491.827622585668, 11589.52314305705, 11740.119491038206, 11768.293902365886, 9720.61117555304, 9975.351602145838, 10193.490325483845, 10528.36829790215, 10607.310524815863, 9837.704868853945, 10135.847962280424, 10280.845787313196, 10602.978151226864, 10644.414557199274, 2938.7795915306438, 2946.808457450259, 2971.22748085495, 2982.537706655472, 2992.5660779186896, 1047.7747284333905, 1061.4957894999968, 1062.5324857062867, 1068.513826209073, 1072.9678109656722, 21603.459913501974, 22227.888860555595, 22394.88802555977, 22666.0, 22672.319830405115, 1113.8663360396804, 1134.9546018159347, 1150.815869460899, 1153.3598852636699, 1155.439611788282, 11771.941140294415, 12108.939455302667, 12123.939380303042, 12189.146759726911, 12230.510779568896, 660598.0, 667859.0, 677206.0, 677646.0, 696468.0, 137051.31474342765, 137255.0, 137516.31241843727, 137594.31202843922, 141813.0, 1145.7880292145812, 1251.7121062155572, 1270.3775150176348, 1283.0697744135427, 1285.7878450055637, 19396.8060319395, 19597.608047839247, 19640.0, 19660.0, 19916.302929397403, 63230.683846580476, 64335.35664643481, 64529.0, 66489.0, 66679.66660166669, 82137.0, 82695.7595636078, 82981.17018829734, 83376.7493487586, 83769.0, 15981.200939953189, 16531.834681653512, 16593.33689577806, 16627.83372166311, 16644.58388540296, 24532.877335613208, 24620.0, 24663.50672986566, 24782.0, 24988.250352489453, 18785.718214226523, 18923.148458319683, 19887.900560497106, 20102.698459522828, 20223.29218477346, 15811.367545298059, 16535.25591348368, 16612.418565350155, 16830.737694672705, 18087.909560452114, 20497.48756281105, 20874.165033398494, 20907.163713451293, 20908.16367345289, 21043.368698938444, 16167.464090911344, 16220.35118595243, 16292.592685182964, 16421.67156656884, 16442.83557164413, 19560.0, 19589.020548972778, 19593.510162246057, 19682.704759428907, 19694.507637309183], "value": 13312.356448676548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.7161353536062, 1510.569487696007, 1516.0827699241952, 1534.631688394785, 1537.2697968464981, 17351.479455616336, 17935.0, 17943.192556334947, 18043.0, 18081.90959045203, 17646.735298970525, 17695.380661676845, 17706.46880593581, 17735.556611084696, 17740.0, 3044.467218236811, 3074.892378766749, 3107.4561951658484, 3113.9844300778464, 3116.158637167963, 2999.9700002999907, 3019.743321817648, 3021.7884748067645, 3027.2583217111837, 3034.150437877398, 2990.3421247325555, 3024.8487575621243, 3099.1942095055333, 3103.2086817861414, 3110.8289044102567, 3076.9846150769104, 3078.6921307869256, 3079.9230019249476, 3089.6755840636633, 3116.5636810846386, 2975.6577993530586, 2988.0886329669443, 3009.9398012039637, 3011.8945836895605, 3013.6835632258735, 17057.317707291695, 17360.826391736173, 17382.826171738372, 17407.56481087983, 17429.21568529419, 8780.121987801233, 9028.954855225747, 9036.45781253127, 9048.864267036, 9049.819003619956, 5930.1401296812155, 5968.224130863004, 5972.880542389128, 6038.547108966845, 6045.909311360333, 2116.354511873878, 2150.9354719358444, 2184.859858255371, 2195.857269277508, 2216.6785816056745, 31553.36893262122, 31556.684433155835, 31773.682263177303, 31782.523262151088, 31783.84108079468, 7464.664090115958, 7577.318041376303, 7628.427867909929, 7848.450608457353, 7862.803429914298, 20882.164713411294, 20884.269050583156, 20893.0, 21019.369418917457, 21042.684359734616, 8768.079351667982, 8926.062763409878, 8983.371164018456, 8987.415817971942, 8988.685396011108, 8026.719064832703, 8086.110527841933, 8187.549684767276, 8202.507849528927, 8212.958935205286, 5887.705614719247, 6161.630302181794, 6252.812415627538, 6256.562040657111, 6268.091126786681, 1651.3229575873834, 1671.1560661865924, 1687.2744719770617, 1726.896386216831, 1755.9473215803546, 1018.1142406106586, 1024.4058446101244, 1028.9125424339015, 1041.338749893823, 1043.0716662170673, 9986.800263994679, 10041.598336066476, 10430.582776688847, 10438.843417348746, 10508.106810921005, 1096.1450068946235, 1096.8464414981909, 1102.1898904305328, 1104.779044191165, 1121.2207515776456, 6091.878162436727, 6319.96840015797, 6442.06590044441, 6593.241777195684, 6672.733090676318, 25729.742702572734, 26480.60279095815, 26678.866605666848, 26834.329141771614, 27046.0, 25247.24258272255, 27252.182434526996, 27439.45121097567, 27513.31216719558, 27607.30981725433, 11711.648650540497, 12284.324362160167, 12377.566785162477, 12490.75018499643, 12534.686632834251, 10094.949525252621, 10171.186305095427, 10200.438975856103, 10292.485375731334, 10439.634612788515, 22154.55690886141, 22344.0, 22354.888225558767, 22381.77618223797, 22537.549249015257, 23423.180188693314, 23530.64704029407, 23772.524549508566, 23910.28269151928, 24367.14714984967, 13037.608871733863, 13129.212247265195, 13313.0, 13335.933320333335, 13372.732545349234, 15187.392504299703, 15277.618059548156, 15340.693186136437, 15346.616334591277, 15368.923155384151, 12216.572419965258, 12303.323317217639, 12516.31160286193, 12545.435455404346, 12769.297688627215, 11565.942170289094, 11724.413779311171, 11795.174337796616, 11819.290842549475, 12135.271883687006, 10560.313579617301, 10728.624498142528, 10762.354258744188, 10836.783264334512, 10845.0, 7943.086545047394, 7944.602769861368, 7980.680772769024, 7999.720009799629, 8084.0, 8338.29124524398, 8459.534725590152, 8553.95723021381, 8565.400421970402, 8599.656013759379], "value": 7691.110933956315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6731430398977, 583.9620424672396, 605.1920685884344, 620.3455354600895, 628.0453710360252, 6330.240371155456, 6368.586041907279, 6404.551681382305, 6412.326705695905, 6417.294097649261, 6251.906221406683, 6286.3399343069, 6327.1774669293045, 6345.4923606111515, 6349.650769207692, 5264.921026184601, 5276.287701160332, 5296.496832800878, 5301.416844147141, 5315.787368505275, 4990.500949905017, 5153.304303918979, 5221.765020574065, 5270.235815806705, 5275.36695596529, 5056.393232812067, 5116.283720279164, 5141.922871156917, 5143.151380022292, 5156.226566015091, 5050.974745126287, 5086.135356989321, 5104.719240441774, 5135.666181698215, 5156.097682905495, 4649.1399091167905, 4660.510646382115, 4676.550269416492, 4686.320483529869, 4690.835820746292, 6253.624782513064, 6256.749730010794, 6266.561340706153, 6281.905771413432, 6329.4619957303685, 5935.584509084366, 6061.939380606225, 6073.0, 6100.664463454508, 6116.816495505142, 6659.533832631718, 6745.1905771307265, 6790.197489405899, 6800.251972283045, 6815.15990682513, 5017.623678224148, 5232.267482552407, 5247.1866860636665, 5266.236395722637, 5270.8155214567305, 6972.2330543640155, 6975.476839237078, 7097.609631470267, 7127.607981561064, 7140.5001649884525, 5370.8657283567445, 5381.829082461124, 5394.730263486888, 5413.702246376409, 5419.403865574784, 5447.918281225785, 5450.528357343495, 5464.808731694451, 5497.92790405875, 5510.91733623996, 5946.613470124428, 6045.697715114226, 6050.757969681252, 6054.909176362358, 6056.757729690763, 6753.358430949052, 6775.593464392152, 6827.658617069127, 6838.931610683929, 6887.830333445049, 1873.7751469823709, 1879.6616609010237, 1887.2356695538328, 1896.662852688851, 1900.5343690795844, 1293.1012946002627, 1336.2984433172662, 1360.3062438156612, 1361.1492816989382, 1373.7527245095978, 6228.408301211378, 6278.686065696788, 6333.828241775286, 6377.64922929234, 6446.7421303148285, 6748.0, 6789.355011273921, 6832.965835170792, 6847.589144651337, 6869.931300687029, 6350.4919606432295, 6359.777407790705, 6373.936260637334, 6402.167718196604, 6443.48452123829, 3618.1316484044164, 3621.9275614487565, 3633.9818300908855, 3656.305301992613, 3658.7073034157734, 7175.390091842252, 7247.746328878464, 7249.347558719741, 7269.164046134656, 7286.453515986323, 6985.441164706811, 7011.789646310619, 7013.684384202723, 7058.188308344606, 7083.964580177066, 7020.5787652741, 7077.504574679826, 7108.609026503592, 7188.424926006011, 7189.1373035235065, 6730.528862979544, 6755.392014718699, 6780.38976492118, 6785.389314961677, 6868.793936181923, 6801.591904485746, 6803.693833777393, 6827.0, 6848.691808868513, 6946.221511395483, 7162.033125527987, 7181.9586160005465, 7194.172670143001, 7212.4951253411755, 7243.130824301117, 5378.310844577712, 5388.434214407587, 5412.025835349675, 5416.2688037114485, 5430.049741295336, 6588.637624930675, 6704.832379190364, 6803.557768745016, 6838.897416538656, 6909.723611055702, 6295.370462953668, 6564.540482166202, 6611.933880661132, 6645.269020407654, 6697.296783837822, 6534.901976470262, 6664.333566643297, 6680.131582894192, 6687.264400915798, 6698.66506674674, 6521.706523206372, 6558.508111891722, 6646.169228846395, 6646.767363142267, 6663.7001334941015, 6673.265940746417, 6682.599044057372, 6748.257691654012, 6759.357861003196, 6769.526133170828, 6220.937790622217, 6412.647304398303, 6550.6069635822005, 6565.474762018932, 6577.539572229898], "value": 5317.004981102217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [987.9753006174849, 1021.9744506387341, 1036.6889933020097, 1044.9268551201415, 1056.4612047855592, 19448.611027779454, 20113.0, 20163.294284700038, 20163.495912602175, 20169.59660806783, 18154.727679084823, 18432.447026589223, 18635.720464193048, 18999.0, 19087.809121908776, 1072.5763323487217, 1089.6894385100247, 1092.2354351953625, 1092.5575142067476, 1094.0, 1068.2201992545447, 1096.6545538155456, 1105.4417519152817, 1118.0440723181684, 1119.2668801934706, 1168.649405178443, 1178.6169494914186, 1178.770139822735, 1181.2499063094954, 1181.3384504677365, 1173.7476442564846, 1175.506287359311, 1176.3001014396464, 1176.805827038546, 1177.375990724913, 863.4215075899162, 863.4387648028769, 863.7581477186397, 865.1089377940731, 865.4071960706935, 19802.60394792096, 19817.702734458995, 19975.400737977885, 19989.70015449755, 20008.79991200084, 19921.701174482394, 20108.49728756778, 20535.589288214152, 20544.897275513526, 20551.794482055288, 17986.55033624157, 18068.36760713369, 18193.545161371072, 18225.362112326136, 18261.0, 3548.520949671787, 3935.803209839525, 3947.4868267125375, 3950.920981580381, 3953.940690889639, 159446.0, 159515.0, 160241.0, 160404.0, 161088.19455902762, 15918.76121858173, 15956.840431595767, 16094.839051609333, 16096.597585060466, 16141.59646008859, 27253.182404527895, 27438.0, 27767.861160694472, 27782.444351112863, 28021.439571208462, 9122.589483473259, 9153.17621414076, 9167.083291670913, 9171.266298696088, 9174.082591740906, 4783.736894470838, 4830.227163653799, 4833.299171620095, 4843.564079232886, 4852.1508735971065, 5877.706114694333, 6110.480609148183, 6141.385861413913, 6159.4456498915315, 6184.721687523982, 1140.749035212252, 1171.7305019845483, 1181.3974872814754, 1189.042820529482, 1193.0634451955173, 714.8141483214401, 728.8578727148155, 731.7438896386222, 748.1770052941721, 753.5441058159844, 11323.584551931008, 11802.5869094583, 12179.573714919936, 12575.0, 12704.936475317749, 692.2765709833136, 692.5498426023024, 698.9196242432083, 703.0649236515422, 718.5437247347971, 5541.861453463695, 5626.156076588544, 5669.2346533218315, 5780.364159942403, 5825.1844741736195, 146497.0, 148438.0, 149185.0, 151298.0, 151956.0, 128690.0, 135387.32306338602, 136524.0, 136874.0, 138165.0, 115777.0, 116760.41619791847, 117907.0, 119091.40454297846, 120280.3985980082, 10726.302790318605, 10898.727531811768, 11048.723781905517, 11100.0, 11170.832437513607, 58027.0, 58108.41891581199, 58424.415755841896, 59620.0, 60079.39920600738, 73945.63027184829, 74155.0, 74506.0, 76338.0, 76471.61764191143, 15850.682986339978, 16138.0, 16158.596035098746, 16159.272832722321, 16177.191140443167, 17003.91498042502, 17092.572685682957, 17169.0, 17298.308067677655, 17314.480565582548, 16248.0, 16528.504144875675, 16568.502944911674, 16654.66690666204, 16658.083805390335, 16274.837251627332, 16367.427140050517, 16524.173791310626, 16553.420630277884, 16689.74965375496, 16193.0, 16233.0, 16244.269007894909, 16399.91800040992, 16476.67046659036, 11471.197016209118, 11482.36846973391, 11610.187286889837, 11624.837516248308, 11820.349880756641, 11628.94185529067, 11671.474783634927, 11719.238249513754, 11744.942955134078, 12003.699907502032], "value": 9616.675522086707, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1351.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 104.0, 104.0, 106.0, 107.0, 96.0, 105.0, 106.0, 105.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 112.0, 113.0, 109.0, 110.0, 114.0, 109.0, 110.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 163.0, 163.0, 161.0, 162.0, 163.0, 165.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 76.0, 74.0, 74.0, 73.0, 74.0, 72.0, 73.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 84.0, 77.0, 77.0, 77.0, 77.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 109.0, 113.0, 113.0, 110.0, 113.0, 111.0, 113.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0, 150.0, 151.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 99.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 46.0, 49.0, 52.0, 44.0, 44.0, 44.0, 44.0], "value": 45.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 68.0, 70.0, 68.0, 69.0, 68.0, 70.0, 69.0, 69.0, 74.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 98.0, 101.0, 103.0, 101.0, 106.0, 103.0, 100.0, 109.0], "value": 102.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 145.0, 162.0, 153.0, 147.0, 160.0, 150.0, 148.0, 152.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 59.0, 57.0, 57.0, 57.0, 58.0, 58.0, 56.0, 60.0], "value": 58.0, "unit": "score"}]}]} 05:52:40 INFO - Return code: 0 05:52:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:52:40 INFO - # TBPL SUCCESS # 05:52:40 INFO - Running post-action listener: _package_coverage_data 05:52:40 INFO - Running post-action listener: _resource_record_post_action 05:52:40 INFO - [mozharness: 2017-10-02 12:52:40.424423Z] Finished run-tests step (success) 05:52:40 INFO - Running post-run listener: _resource_record_post_run 05:52:40 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281427968; Read time: 16; Write time: 97724 05:52:40 INFO - TinderboxPrint: CPU usage
13.0% 05:52:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:52:40 INFO - TinderboxPrint: I/O write bytes / time
281,427,968 / 97,724 05:52:40 INFO - TinderboxPrint: CPU idle
8,182.8 (87.0%) 05:52:40 INFO - TinderboxPrint: CPU user
1,178.8 (12.5%) 05:52:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:52:40 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9261056; Read time: 0; Write time: 1020 05:52:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:52:40 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272166912; Read time: 16; Write time: 96704 05:52:41 INFO - Running post-run listener: _upload_blobber_files 05:52:41 INFO - Blob upload gear active. 05:52:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:41 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 05:52:41 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:41 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:42 INFO - (blobuploader) - INFO - Done attempting. 05:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:46 INFO - (blobuploader) - INFO - Done attempting. 05:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:47 INFO - (blobuploader) - INFO - Done attempting. 05:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:47 INFO - (blobuploader) - INFO - Done attempting. 05:52:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:47 INFO - Return code: 0 05:52:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/182aab656f2b0067fdb5826071a765313d7cbc31373ee13b7c2ac324ff8c2986156fdeb40e1c3897d6b188dae7a23b9f6f85c51f82544e3238162d9b137d7452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/571b428d6367cc485910df5ba537505ab1505fa83d242f15eadcf9b36bc140e658ec5941a1e4a891ba51d557eb5bd00db886310e9a8251a7701cf464c02a5b50", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e3ae61fb649de0ce7d4e166e4dcecdbf2103eaddea5b784fa89c893a062c7504fa6021ed36fde17d206e06959557baa1eed561ec28366bff310656da121f261", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24329e60ae811f06b4e2d588157ff49877e5f61c0eab4415c27efb5f1b79c203987990f9b901e5e136606381970e7cd69b35cae62626711a6d0446eb2fa69932"} 05:52:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:47 INFO - Contents: 05:52:47 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/182aab656f2b0067fdb5826071a765313d7cbc31373ee13b7c2ac324ff8c2986156fdeb40e1c3897d6b188dae7a23b9f6f85c51f82544e3238162d9b137d7452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/571b428d6367cc485910df5ba537505ab1505fa83d242f15eadcf9b36bc140e658ec5941a1e4a891ba51d557eb5bd00db886310e9a8251a7701cf464c02a5b50", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e3ae61fb649de0ce7d4e166e4dcecdbf2103eaddea5b784fa89c893a062c7504fa6021ed36fde17d206e06959557baa1eed561ec28366bff310656da121f261", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24329e60ae811f06b4e2d588157ff49877e5f61c0eab4415c27efb5f1b79c203987990f9b901e5e136606381970e7cd69b35cae62626711a6d0446eb2fa69932"} 05:52:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:47 INFO - Copying logs to upload dir... 05:52:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.141626 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 05:52:48.067457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 05:52:48.071602) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/182aab656f2b0067fdb5826071a765313d7cbc31373ee13b7c2ac324ff8c2986156fdeb40e1c3897d6b188dae7a23b9f6f85c51f82544e3238162d9b137d7452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/571b428d6367cc485910df5ba537505ab1505fa83d242f15eadcf9b36bc140e658ec5941a1e4a891ba51d557eb5bd00db886310e9a8251a7701cf464c02a5b50", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e3ae61fb649de0ce7d4e166e4dcecdbf2103eaddea5b784fa89c893a062c7504fa6021ed36fde17d206e06959557baa1eed561ec28366bff310656da121f261", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24329e60ae811f06b4e2d588157ff49877e5f61c0eab4415c27efb5f1b79c203987990f9b901e5e136606381970e7cd69b35cae62626711a6d0446eb2fa69932"} build_url:https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/DsGFmAXuTpak9zr5OJMekw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/182aab656f2b0067fdb5826071a765313d7cbc31373ee13b7c2ac324ff8c2986156fdeb40e1c3897d6b188dae7a23b9f6f85c51f82544e3238162d9b137d7452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/571b428d6367cc485910df5ba537505ab1505fa83d242f15eadcf9b36bc140e658ec5941a1e4a891ba51d557eb5bd00db886310e9a8251a7701cf464c02a5b50", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3e3ae61fb649de0ce7d4e166e4dcecdbf2103eaddea5b784fa89c893a062c7504fa6021ed36fde17d206e06959557baa1eed561ec28366bff310656da121f261", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24329e60ae811f06b4e2d588157ff49877e5f61c0eab4415c27efb5f1b79c203987990f9b901e5e136606381970e7cd69b35cae62626711a6d0446eb2fa69932"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 05:52:48.099695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:52:48.100008) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506947536.317748-826013134 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 05:52:48.452067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 05:52:48.452395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 05:52:48.452702) ========= ========= Total master_lag: 0.56 =========