builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-076 starttime: 1506971425.03 results: success (0) revision: 15f221f491f707b1e8e46da344b6dd5a394b1242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.028029) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.029076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.035381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.053799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.054060) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 12:10:25-- 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% 25.6M=0s 2017-10-02 12:10:25 (25.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.195238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.195547) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014595 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.255148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:25.255617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 15f221f491f707b1e8e46da344b6dd5a394b1242 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 15f221f491f707b1e8e46da344b6dd5a394b1242 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 12:10:25,867 truncating revision to first 12 chars 2017-10-02 12:10:25,867 Setting DEBUG logging. 2017-10-02 12:10:25,867 attempt 1/10 2017-10-02 12:10:25,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/15f221f491f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 12:10:26,336 unpacking tar archive at: mozilla-central-15f221f491f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.843041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:26.121830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:26.122147) ========= script_repo_revision: 15f221f491f707b1e8e46da344b6dd5a394b1242 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:26.122558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:26.122828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 12:10:26.152529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 12:10:26.152836) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:10:26 INFO - MultiFileLogger online at 20171002 12:10:26 in /builds/slave/test 12:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:10:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:10:26 INFO - {'append_to_log': False, 12:10:26 INFO - 'base_work_dir': '/builds/slave/test', 12:10:26 INFO - 'blob_upload_branch': 'Firefox', 12:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:10:26 INFO - 'branch': 'Firefox', 12:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:10:26 INFO - 'code_coverage': False, 12:10:26 INFO - 'config_files': ('talos/linux_config.py',), 12:10:26 INFO - 'default_actions': ('clobber', 12:10:26 INFO - 'read-buildbot-config', 12:10:26 INFO - 'download-and-extract', 12:10:26 INFO - 'populate-webroot', 12:10:26 INFO - 'create-virtualenv', 12:10:26 INFO - 'install', 12:10:26 INFO - 'setup-mitmproxy', 12:10:26 INFO - 'run-tests'), 12:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:10:26 INFO - 'disable_ccov_upload': False, 12:10:26 INFO - 'disable_stylo': False, 12:10:26 INFO - 'download_minidump_stackwalk': True, 12:10:26 INFO - 'download_symbols': 'ondemand', 12:10:26 INFO - 'enable_stylo': False, 12:10:26 INFO - 'enable_webrender': False, 12:10:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:10:26 INFO - 'gecko_profile': False, 12:10:26 INFO - 'gecko_profile_interval': 0, 12:10:26 INFO - 'installer_path': 'installer.exe', 12:10:26 INFO - 'log_level': 'info', 12:10:26 INFO - 'log_name': 'talos', 12:10:26 INFO - 'log_to_console': True, 12:10:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:10:26 INFO - 'opt_config_files': (), 12:10:26 INFO - 'pip_index': False, 12:10:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:10:26 INFO - 'system_bits': '32', 12:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:10:26 INFO - 'title': 'talos-linux64-ix-076', 12:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:10:26 INFO - 'use_talos_json': True, 12:10:26 INFO - 'verify': 'False', 12:10:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:10:26 INFO - 'work_dir': 'build'} 12:10:26 INFO - [mozharness: 2017-10-02 19:10:26.902751Z] Running clobber step. 12:10:26 INFO - Running pre-action listener: _resource_record_pre_action 12:10:26 INFO - Running main action method: clobber 12:10:26 INFO - rmtree: /builds/slave/test/build 12:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:10:27 INFO - Running post-action listener: _resource_record_post_action 12:10:27 INFO - [mozharness: 2017-10-02 19:10:27.896918Z] Finished clobber step (success) 12:10:27 INFO - [mozharness: 2017-10-02 19:10:27.897015Z] Running read-buildbot-config step. 12:10:27 INFO - Running pre-action listener: _resource_record_pre_action 12:10:27 INFO - Running main action method: read_buildbot_config 12:10:27 INFO - Using buildbot properties: 12:10:27 INFO - { 12:10:27 INFO - "project": "", 12:10:27 INFO - "product": "firefox", 12:10:27 INFO - "who": "ffxbld@noreply.mozilla.org", 12:10:27 INFO - "installer_path": "public/build/target.tar.bz2", 12:10:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:10:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:10:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:10:27 INFO - "stage_platform": "linux64-pgo", 12:10:27 INFO - "basedir": "/builds/slave/test", 12:10:27 INFO - "buildnumber": 83, 12:10:27 INFO - "platform": "ubuntu64_hw", 12:10:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:10:27 INFO - "slavebuilddir": "test", 12:10:27 INFO - "taskId": "GNdEnmpBQU2iSBBnpGLCAg", 12:10:27 INFO - "branch": "mozilla-central", 12:10:27 INFO - "script_repo_revision": "production", 12:10:27 INFO - "revision": "15f221f491f707b1e8e46da344b6dd5a394b1242", 12:10:27 INFO - "slavename": "talos-linux64-ix-076", 12:10:27 INFO - "repo_path": "mozilla-central" 12:10:27 INFO - } 12:10:27 INFO - Finding installer, test and symbols from parent task. 12:10:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GNdEnmpBQU2iSBBnpGLCAg'}, attempt #1 12:10:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GNdEnmpBQU2iSBBnpGLCAg'}, attempt #1 12:10:28 INFO - Task dependencies: HoZpg5sHQb2RIyQu0rOepw 12:10:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw'}, attempt #1 12:10:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 12:10:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.test_packages.json 12:10:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.crashreporter-symbols.zip 12:10:29 INFO - Running post-action listener: _resource_record_post_action 12:10:29 INFO - [mozharness: 2017-10-02 19:10:29.339192Z] Finished read-buildbot-config step (success) 12:10:29 INFO - [mozharness: 2017-10-02 19:10:29.339410Z] Running download-and-extract step. 12:10:29 INFO - Running pre-action listener: _resource_record_pre_action 12:10:29 INFO - Running main action method: download_and_extract 12:10:29 INFO - mkdir: /builds/slave/test/build/tests 12:10:29 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')]} 12:10:29 INFO - trying https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.test_packages.json 12:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:10:29 INFO - Downloaded 989 bytes. 12:10:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:10:29 INFO - Using the following test package requirements: 12:10:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:10:29 INFO - u'common': [u'target.common.tests.zip'], 12:10:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:10:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:10:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:10:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:10:29 INFO - u'mozbase': [u'target.common.tests.zip'], 12:10:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:10:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:10:29 INFO - u'web-platform': [u'target.common.tests.zip', 12:10:29 INFO - u'target.web-platform.tests.tar.gz'], 12:10:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:10:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:10:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.common.tests.zip 12:10:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:10:29 INFO - Fetch https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.common.tests.zip into memory 12:10:32 INFO - Content-Length response header: 55917748 12:10:32 INFO - Bytes received: 55917748 12:10:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.talos.tests.zip 12:10:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:10:42 INFO - Fetch https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.talos.tests.zip into memory 12:10:44 INFO - Content-Length response header: 14522385 12:10:44 INFO - Bytes received: 14522385 12:10:44 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')]} 12:10:44 INFO - trying https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 12:10:44 INFO - Downloading https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:10:46 INFO - Downloaded 62293995 bytes. 12:10:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 12:10:46 INFO - mkdir: /builds/slave/test/properties 12:10:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:10:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:10:46 INFO - Contents: 12:10:46 INFO - build_url:https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 12:10:46 INFO - Running post-action listener: _resource_record_post_action 12:10:46 INFO - Running post-action listener: find_tests_for_verification 12:10:46 INFO - Running post-action listener: set_extra_try_arguments 12:10:46 INFO - [mozharness: 2017-10-02 19:10:46.999972Z] Finished download-and-extract step (success) 12:10:47 INFO - [mozharness: 2017-10-02 19:10:47.000125Z] Running populate-webroot step. 12:10:47 INFO - Running pre-action listener: _resource_record_pre_action 12:10:47 INFO - Running main action method: populate_webroot 12:10:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:10:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['tresize', 12:10:47 INFO - 'tcanvasmark']}, 12:10:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:10:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['dromaeo_css', 12:10:47 INFO - 'kraken']}, 12:10:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'tests': ['damp', 'tps']}, 12:10:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['damp', 'tps']}, 12:10:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:10:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['dromaeo_dom']}, 12:10:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:10:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['basic_compositor_video', 12:10:47 INFO - 'glvideo']}, 12:10:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:10:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['ts_paint_webext', 12:10:47 INFO - 'tp5o_webext']}, 12:10:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:10:47 INFO - 'ts_paint', 12:10:47 INFO - 'tpaint', 12:10:47 INFO - 'sessionrestore', 12:10:47 INFO - 'sessionrestore_many_windows', 12:10:47 INFO - 'sessionrestore_no_auto_restore', 12:10:47 INFO - 'tabpaint', 12:10:47 INFO - 'cpstartup']}, 12:10:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['a11yr', 12:10:47 INFO - 'ts_paint', 12:10:47 INFO - 'tpaint', 12:10:47 INFO - 'sessionrestore', 12:10:47 INFO - 'sessionrestore_many_windows', 12:10:47 INFO - 'sessionrestore_no_auto_restore', 12:10:47 INFO - 'tabpaint', 12:10:47 INFO - 'cpstartup']}, 12:10:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:10:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:10:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['perf_reftest_singletons']}, 12:10:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['perf_reftest']}, 12:10:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:10:47 INFO - 'tsvgr_opacity', 12:10:47 INFO - 'tart', 12:10:47 INFO - 'tscrollx', 12:10:47 INFO - 'tsvg_static']}, 12:10:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['tsvgx', 12:10:47 INFO - 'tsvgr_opacity', 12:10:47 INFO - 'tart', 12:10:47 INFO - 'tscrollx', 12:10:47 INFO - 'tsvg_static']}, 12:10:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:10:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--disable-stylo'], 12:10:47 INFO - 'tests': ['tp5o']}, 12:10:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:10:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:10:47 INFO - 'talos_options': ['--mitmproxy', 12:10:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:10:47 INFO - '--firstNonBlankPaint'], 12:10:47 INFO - 'tests': ['tp6_google', 12:10:47 INFO - 'tp6_youtube', 12:10:47 INFO - 'tp6_amazon', 12:10:47 INFO - 'tp6_facebook']}, 12:10:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:10:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:10:47 INFO - 'talos_options': ['--disable-stylo', 12:10:47 INFO - '--mitmproxy', 12:10:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:10:47 INFO - '--firstNonBlankPaint'], 12:10:47 INFO - 'tests': ['tp6_google', 12:10:47 INFO - 'tp6_youtube', 12:10:47 INFO - 'tp6_amazon', 12:10:47 INFO - 'tp6_facebook']}, 12:10:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:10:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:10:47 INFO - 'talos_options': ['--stylo-threads=1', 12:10:47 INFO - '--mitmproxy', 12:10:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:10:47 INFO - '--firstNonBlankPaint'], 12:10:47 INFO - 'tests': ['tp6_google', 12:10:47 INFO - 'tp6_youtube', 12:10:47 INFO - 'tp6_amazon', 12:10:47 INFO - 'tp6_facebook']}, 12:10:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--xperf_path', 12:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:47 INFO - 'tests': ['tp5n']}, 12:10:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:10:47 INFO - 'talos_options': ['--disable-stylo', 12:10:47 INFO - '--xperf_path', 12:10:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:47 INFO - 'tests': ['tp5n']}}} 12:10:47 INFO - Running post-action listener: _resource_record_post_action 12:10:47 INFO - [mozharness: 2017-10-02 19:10:47.023943Z] Finished populate-webroot step (success) 12:10:47 INFO - [mozharness: 2017-10-02 19:10:47.024050Z] Running create-virtualenv step. 12:10:47 INFO - Running pre-action listener: _resource_record_pre_action 12:10:47 INFO - Running main action method: create_virtualenv 12:10:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:10:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:10:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:10:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:10:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:10:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:10:47 INFO - Installing distribute.............................................................................................................................................................................................done. 12:10:48 INFO - Installing pip...............done. 12:10:48 INFO - Return code: 0 12:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:10:48 INFO - Reading from file tmpfile_stdout 12:10:48 INFO - Output received: 12:10:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:10:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:10: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')]} 12:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10: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')]} 12:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:10:48 INFO - Using env: {'DISPLAY': ':0', 12:10:48 INFO - 'HOME': '/home/cltbld', 12:10:48 INFO - 'LANG': 'en_US.UTF-8', 12:10:48 INFO - 'LANGUAGE': 'en_US:en', 12:10:48 INFO - 'LOGNAME': 'cltbld', 12:10:48 INFO - 'MAIL': '/var/mail/cltbld', 12:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:48 INFO - 'MOZ_NO_REMOTE': '1', 12:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:48 INFO - 'NO_EM_RESTART': '1', 12:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:48 INFO - 'PWD': '/builds/slave/test', 12:10:48 INFO - 'SHELL': '/bin/bash', 12:10:48 INFO - 'SHLVL': '1', 12:10:48 INFO - 'TERM': 'linux', 12:10:48 INFO - 'TMOUT': '86400', 12:10:48 INFO - 'USER': 'cltbld', 12:10:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:48 INFO - '_': '/tools/buildbot/bin/python'} 12:10:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:10:49 INFO - Downloading/unpacking pip>=1.5 12:10:49 INFO - Running setup.py egg_info for package pip 12:10:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:10:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:10:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:10:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:10:49 INFO - Installing collected packages: pip 12:10:49 INFO - Found existing installation: pip 1.1 12:10:49 INFO - Uninstalling pip: 12:10:49 INFO - Successfully uninstalled pip 12:10:49 INFO - Running setup.py install for pip 12:10:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:10:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:10:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:10:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:10:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:10:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:10:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:10:49 INFO - Successfully installed pip 12:10:49 INFO - Cleaning up... 12:10:49 INFO - Return code: 0 12:10:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:10:49 INFO - Using env: {'DISPLAY': ':0', 12:10:49 INFO - 'HOME': '/home/cltbld', 12:10:49 INFO - 'LANG': 'en_US.UTF-8', 12:10:49 INFO - 'LANGUAGE': 'en_US:en', 12:10:49 INFO - 'LOGNAME': 'cltbld', 12:10:49 INFO - 'MAIL': '/var/mail/cltbld', 12:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:49 INFO - 'MOZ_NO_REMOTE': '1', 12:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:49 INFO - 'NO_EM_RESTART': '1', 12:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:49 INFO - 'PWD': '/builds/slave/test', 12:10:49 INFO - 'SHELL': '/bin/bash', 12:10:49 INFO - 'SHLVL': '1', 12:10:49 INFO - 'TERM': 'linux', 12:10:49 INFO - 'TMOUT': '86400', 12:10:49 INFO - 'USER': 'cltbld', 12:10:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:49 INFO - '_': '/tools/buildbot/bin/python'} 12:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:49 INFO - Downloading/unpacking psutil>=3.1.1 12:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:10:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:50 INFO - Installing collected packages: psutil 12:10:50 INFO - Running setup.py install for psutil 12:10:50 INFO - building 'psutil._psutil_linux' extension 12:10:50 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 12:10:51 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 12:10:51 INFO - building 'psutil._psutil_posix' extension 12:10:51 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 12:10:51 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 12:10:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:51 INFO - Successfully installed psutil 12:10:51 INFO - Cleaning up... 12:10:51 INFO - Return code: 0 12:10:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:10: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')]} 12:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10: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')]} 12:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:10:51 INFO - Using env: {'DISPLAY': ':0', 12:10:51 INFO - 'HOME': '/home/cltbld', 12:10:51 INFO - 'LANG': 'en_US.UTF-8', 12:10:51 INFO - 'LANGUAGE': 'en_US:en', 12:10:51 INFO - 'LOGNAME': 'cltbld', 12:10:51 INFO - 'MAIL': '/var/mail/cltbld', 12:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:51 INFO - 'MOZ_NO_REMOTE': '1', 12:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:51 INFO - 'NO_EM_RESTART': '1', 12:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:51 INFO - 'PWD': '/builds/slave/test', 12:10:51 INFO - 'SHELL': '/bin/bash', 12:10:51 INFO - 'SHLVL': '1', 12:10:51 INFO - 'TERM': 'linux', 12:10:51 INFO - 'TMOUT': '86400', 12:10:51 INFO - 'USER': 'cltbld', 12:10:51 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:51 INFO - '_': '/tools/buildbot/bin/python'} 12:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:10:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:10:53 INFO - Installing collected packages: mozsystemmonitor 12:10:53 INFO - Running setup.py install for mozsystemmonitor 12:10:53 INFO - Successfully installed mozsystemmonitor 12:10:53 INFO - Cleaning up... 12:10:53 INFO - Return code: 0 12:10:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:10:53 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')]} 12:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:53 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')]} 12:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:53 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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:53 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 12:10:53 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 12:10:53 INFO - Using env: {'DISPLAY': ':0', 12:10:53 INFO - 'HOME': '/home/cltbld', 12:10:53 INFO - 'LANG': 'en_US.UTF-8', 12:10:53 INFO - 'LANGUAGE': 'en_US:en', 12:10:53 INFO - 'LOGNAME': 'cltbld', 12:10:53 INFO - 'MAIL': '/var/mail/cltbld', 12:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:53 INFO - 'MOZ_NO_REMOTE': '1', 12:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:53 INFO - 'NO_EM_RESTART': '1', 12:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:53 INFO - 'PWD': '/builds/slave/test', 12:10:53 INFO - 'SHELL': '/bin/bash', 12:10:53 INFO - 'SHLVL': '1', 12:10:53 INFO - 'TERM': 'linux', 12:10:53 INFO - 'TMOUT': '86400', 12:10:53 INFO - 'USER': 'cltbld', 12:10:53 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:53 INFO - '_': '/tools/buildbot/bin/python'} 12:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:54 INFO - Downloading/unpacking jsonschema==2.5.1 12:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:10:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:10: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 12:10: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 12:10: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 12:10: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 12:10:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:10:55 INFO - warning: no files found matching '*.txt' 12:10:55 INFO - no previously-included directories found matching 'build' 12:10:55 INFO - no previously-included directories found matching 'dist' 12:10:55 INFO - no previously-included directories found matching '.git*' 12:10:55 INFO - Installing collected packages: jsonschema, functools32 12:10:55 INFO - Running setup.py install for functools32 12:10:55 INFO - warning: no files found matching '*.txt' 12:10:55 INFO - no previously-included directories found matching 'build' 12:10:55 INFO - no previously-included directories found matching 'dist' 12:10:55 INFO - no previously-included directories found matching '.git*' 12:10:55 INFO - Successfully installed jsonschema functools32 12:10:55 INFO - Cleaning up... 12:10:55 INFO - Return code: 0 12:10:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:10:55 INFO - Using env: {'DISPLAY': ':0', 12:10:55 INFO - 'HOME': '/home/cltbld', 12:10:55 INFO - 'LANG': 'en_US.UTF-8', 12:10:55 INFO - 'LANGUAGE': 'en_US:en', 12:10:55 INFO - 'LOGNAME': 'cltbld', 12:10:55 INFO - 'MAIL': '/var/mail/cltbld', 12:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:55 INFO - 'MOZ_NO_REMOTE': '1', 12:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:55 INFO - 'NO_EM_RESTART': '1', 12:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:55 INFO - 'PWD': '/builds/slave/test', 12:10:55 INFO - 'SHELL': '/bin/bash', 12:10:55 INFO - 'SHLVL': '1', 12:10:55 INFO - 'TERM': 'linux', 12:10:55 INFO - 'TMOUT': '86400', 12:10:55 INFO - 'USER': 'cltbld', 12:10:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:55 INFO - '_': '/tools/buildbot/bin/python'} 12:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:10:55 INFO - Cleaning up... 12:10:55 INFO - Return code: 0 12:10:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:10:55 INFO - Using env: {'DISPLAY': ':0', 12:10:55 INFO - 'HOME': '/home/cltbld', 12:10:55 INFO - 'LANG': 'en_US.UTF-8', 12:10:55 INFO - 'LANGUAGE': 'en_US:en', 12:10:55 INFO - 'LOGNAME': 'cltbld', 12:10:55 INFO - 'MAIL': '/var/mail/cltbld', 12:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:55 INFO - 'MOZ_NO_REMOTE': '1', 12:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:55 INFO - 'NO_EM_RESTART': '1', 12:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:55 INFO - 'PWD': '/builds/slave/test', 12:10:55 INFO - 'SHELL': '/bin/bash', 12:10:55 INFO - 'SHLVL': '1', 12:10:55 INFO - 'TERM': 'linux', 12:10:55 INFO - 'TMOUT': '86400', 12:10:55 INFO - 'USER': 'cltbld', 12:10:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:55 INFO - '_': '/tools/buildbot/bin/python'} 12:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:10:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:10: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 12:10: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 12:10: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 12:10: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 12:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:10:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:10: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 12:10: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 12:10: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 12:10: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 12:10:57 INFO - Downloading docopt-0.6.1.tar.gz 12:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:10:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:10:57 INFO - Running setup.py install for blobuploader 12:10:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:10:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:10:57 INFO - Running setup.py install for requests 12:10:58 INFO - Running setup.py install for docopt 12:10:58 INFO - Successfully installed blobuploader requests docopt 12:10:58 INFO - Cleaning up... 12:10:58 INFO - Return code: 0 12:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:58 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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:10:58 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 12:10:58 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 12:10:58 INFO - Using env: {'DISPLAY': ':0', 12:10:58 INFO - 'HOME': '/home/cltbld', 12:10:58 INFO - 'LANG': 'en_US.UTF-8', 12:10:58 INFO - 'LANGUAGE': 'en_US:en', 12:10:58 INFO - 'LOGNAME': 'cltbld', 12:10:58 INFO - 'MAIL': '/var/mail/cltbld', 12:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:58 INFO - 'MOZ_NO_REMOTE': '1', 12:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:58 INFO - 'NO_EM_RESTART': '1', 12:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:58 INFO - 'PWD': '/builds/slave/test', 12:10:58 INFO - 'SHELL': '/bin/bash', 12:10:58 INFO - 'SHLVL': '1', 12:10:58 INFO - 'TERM': 'linux', 12:10:58 INFO - 'TMOUT': '86400', 12:10:58 INFO - 'USER': 'cltbld', 12:10:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:58 INFO - '_': '/tools/buildbot/bin/python'} 12:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:58 INFO - Running setup.py (path:/tmp/pip-wjUnN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:58 INFO - Running setup.py (path:/tmp/pip-MWqxLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:58 INFO - Running setup.py (path:/tmp/pip-FV78VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:58 INFO - Running setup.py (path:/tmp/pip-OjK1IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:58 INFO - Running setup.py (path:/tmp/pip-zyMUL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:59 INFO - Running setup.py (path:/tmp/pip-Q22jhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:59 INFO - Running setup.py (path:/tmp/pip-NRZsDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:59 INFO - Running setup.py (path:/tmp/pip-KSN0W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:59 INFO - Running setup.py (path:/tmp/pip-veeP6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:59 INFO - Running setup.py (path:/tmp/pip-zjil6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:59 INFO - Running setup.py (path:/tmp/pip-sNOFxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:59 INFO - Running setup.py (path:/tmp/pip-Nb8ASH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:59 INFO - Running setup.py (path:/tmp/pip-P90ZGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:59 INFO - Running setup.py (path:/tmp/pip-1YwxVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:59 INFO - Running setup.py (path:/tmp/pip-xM0Ye5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:59 INFO - Running setup.py (path:/tmp/pip-7TIoHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:59 INFO - Running setup.py (path:/tmp/pip-TyHbgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:10:59 INFO - Running setup.py install for manifestparser 12:10:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:10:59 INFO - Running setup.py install for mozcrash 12:11:00 INFO - Running setup.py install for mozdebug 12:11:00 INFO - Running setup.py install for mozdevice 12:11:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for mozfile 12:11:00 INFO - Running setup.py install for mozhttpd 12:11:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for mozinfo 12:11:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for mozInstall 12:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for mozleak 12:11:00 INFO - Running setup.py install for mozlog 12:11:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for moznetwork 12:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:11:00 INFO - Running setup.py install for mozprocess 12:11:01 INFO - Running setup.py install for mozprofile 12:11:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Running setup.py install for mozrunner 12:11:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Running setup.py install for mozscreenshot 12:11:01 INFO - Running setup.py install for moztest 12:11:01 INFO - Running setup.py install for mozversion 12:11:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:11:01 INFO - Cleaning up... 12:11:01 INFO - Return code: 0 12:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:01 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')]} 12:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:01 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')]} 12:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:01 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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:11:01 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 12:11:01 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 12:11:01 INFO - Using env: {'DISPLAY': ':0', 12:11:01 INFO - 'HOME': '/home/cltbld', 12:11:01 INFO - 'LANG': 'en_US.UTF-8', 12:11:01 INFO - 'LANGUAGE': 'en_US:en', 12:11:01 INFO - 'LOGNAME': 'cltbld', 12:11:01 INFO - 'MAIL': '/var/mail/cltbld', 12:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:01 INFO - 'MOZ_NO_REMOTE': '1', 12:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:01 INFO - 'NO_EM_RESTART': '1', 12:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:01 INFO - 'PWD': '/builds/slave/test', 12:11:01 INFO - 'SHELL': '/bin/bash', 12:11:01 INFO - 'SHLVL': '1', 12:11:01 INFO - 'TERM': 'linux', 12:11:01 INFO - 'TMOUT': '86400', 12:11:01 INFO - 'USER': 'cltbld', 12:11:01 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:01 INFO - '_': '/tools/buildbot/bin/python'} 12:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:11:01 INFO - Running setup.py (path:/tmp/pip-Xq_BnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:11:01 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)) 12:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:11:01 INFO - Running setup.py (path:/tmp/pip-LAF56d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:11:01 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)) 12:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:11:01 INFO - Running setup.py (path:/tmp/pip-haUHMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:11:02 INFO - Running setup.py (path:/tmp/pip-dPDjdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:11:02 INFO - Running setup.py (path:/tmp/pip-6ISL04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:11:02 INFO - Running setup.py (path:/tmp/pip-qLh1nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:11:02 INFO - Running setup.py (path:/tmp/pip-26Q9yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:11:02 INFO - Running setup.py (path:/tmp/pip-n1ZY5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:11:02 INFO - Running setup.py (path:/tmp/pip-lNq3Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:11:02 INFO - Running setup.py (path:/tmp/pip-OTAaL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:11:02 INFO - Running setup.py (path:/tmp/pip-eg3SoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:11:02 INFO - Running setup.py (path:/tmp/pip-ZBOsww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:11:02 INFO - Running setup.py (path:/tmp/pip-CJPqAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:11:02 INFO - Running setup.py (path:/tmp/pip-5_d85a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:02 INFO - Running setup.py (path:/tmp/pip-UfBB_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:11:02 INFO - Running setup.py (path:/tmp/pip-TeaDMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:11:02 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)) 12:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:11:02 INFO - Running setup.py (path:/tmp/pip-vRTdPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:04 INFO - Downloading blessings-1.6.tar.gz 12:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:11:04 INFO - Installing collected packages: blessings 12:11:04 INFO - Running setup.py install for blessings 12:11:04 INFO - Successfully installed blessings 12:11:04 INFO - Cleaning up... 12:11:04 INFO - Return code: 0 12:11:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:04 INFO - Reading from file tmpfile_stdout 12:11:04 INFO - Current package versions: 12:11:04 INFO - argparse == 1.2.1 12:11:04 INFO - blessings == 1.6 12:11:04 INFO - blobuploader == 1.2.4 12:11:04 INFO - docopt == 0.6.1 12:11:04 INFO - functools32 == 3.2.3-2 12:11:04 INFO - jsonschema == 2.5.1 12:11:04 INFO - manifestparser == 1.1 12:11:04 INFO - mozInstall == 1.13 12:11:04 INFO - mozcrash == 1.0 12:11:04 INFO - mozdebug == 0.1 12:11:04 INFO - mozdevice == 0.51 12:11:04 INFO - mozfile == 1.2 12:11:04 INFO - mozhttpd == 0.7 12:11:04 INFO - mozinfo == 0.10 12:11:04 INFO - mozleak == 0.1 12:11:04 INFO - mozlog == 3.5 12:11:04 INFO - moznetwork == 0.27 12:11:04 INFO - mozprocess == 0.25 12:11:04 INFO - mozprofile == 0.28 12:11:04 INFO - mozrunner == 6.13 12:11:04 INFO - mozscreenshot == 0.1 12:11:04 INFO - mozsystemmonitor == 0.3 12:11:04 INFO - moztest == 0.8 12:11:04 INFO - mozversion == 1.4 12:11:04 INFO - psutil == 3.1.1 12:11:04 INFO - requests == 1.2.3 12:11:04 INFO - wsgiref == 0.1.2 12:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:04 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')]} 12:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:04 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')]} 12:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:04 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 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:11:04 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 12:11:04 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 12:11:04 INFO - Using env: {'DISPLAY': ':0', 12:11:04 INFO - 'HOME': '/home/cltbld', 12:11:04 INFO - 'LANG': 'en_US.UTF-8', 12:11:04 INFO - 'LANGUAGE': 'en_US:en', 12:11:04 INFO - 'LOGNAME': 'cltbld', 12:11:04 INFO - 'MAIL': '/var/mail/cltbld', 12:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:04 INFO - 'MOZ_NO_REMOTE': '1', 12:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:04 INFO - 'NO_EM_RESTART': '1', 12:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:04 INFO - 'PWD': '/builds/slave/test', 12:11:04 INFO - 'SHELL': '/bin/bash', 12:11:04 INFO - 'SHLVL': '1', 12:11:04 INFO - 'TERM': 'linux', 12:11:04 INFO - 'TMOUT': '86400', 12:11:04 INFO - 'USER': 'cltbld', 12:11:04 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:04 INFO - '_': '/tools/buildbot/bin/python'} 12:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 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)) 12:11:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:11:06 INFO - Installing collected packages: simplejson 12:11:06 INFO - Running setup.py install for simplejson 12:11:06 INFO - building 'simplejson._speedups' extension 12:11:06 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 12:11:06 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 12:11:07 INFO - Successfully installed simplejson 12:11:07 INFO - Cleaning up... 12:11:07 INFO - Return code: 0 12:11:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae09c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', '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 12:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:11:07 INFO - Using env: {'DISPLAY': ':0', 12:11:07 INFO - 'HOME': '/home/cltbld', 12:11:07 INFO - 'LANG': 'en_US.UTF-8', 12:11:07 INFO - 'LANGUAGE': 'en_US:en', 12:11:07 INFO - 'LOGNAME': 'cltbld', 12:11:07 INFO - 'MAIL': '/var/mail/cltbld', 12:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:07 INFO - 'MOZ_NO_REMOTE': '1', 12:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:07 INFO - 'NO_EM_RESTART': '1', 12:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:07 INFO - 'PWD': '/builds/slave/test', 12:11:07 INFO - 'SHELL': '/bin/bash', 12:11:07 INFO - 'SHLVL': '1', 12:11:07 INFO - 'TERM': 'linux', 12:11:07 INFO - 'TMOUT': '86400', 12:11:07 INFO - 'USER': 'cltbld', 12:11:07 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:07 INFO - '_': '/tools/buildbot/bin/python'} 12:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:11:07 INFO - Cleaning up... 12:11:07 INFO - Return code: 0 12:11:07 INFO - Running post-action listener: _resource_record_post_action 12:11:07 INFO - Running post-action listener: _start_resource_monitoring 12:11:07 INFO - Starting resource monitoring. 12:11:07 INFO - [mozharness: 2017-10-02 19:11:07.323757Z] Finished create-virtualenv step (success) 12:11:07 INFO - [mozharness: 2017-10-02 19:11:07.324272Z] Running install step. 12:11:07 INFO - Running pre-action listener: _resource_record_pre_action 12:11:07 INFO - Running main action method: install 12:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:07 INFO - Reading from file tmpfile_stdout 12:11:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:11:07 INFO - Reading from file tmpfile_stdout 12:11:07 INFO - Output received: 12:11:07 INFO - Usage: mozinstall [options] installer 12:11:07 INFO - Options: 12:11:07 INFO - -h, --help show this help message and exit 12:11:07 INFO - -d DEST, --destination=DEST 12:11:07 INFO - Directory to install application into. [default: 12:11:07 INFO - "/builds/slave/test"] 12:11:07 INFO - --app=APP Application being installed. [default: firefox] 12:11:07 INFO - mkdir: /builds/slave/test/build/application 12:11:07 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'] 12:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:11:25 INFO - Reading from file tmpfile_stdout 12:11:25 INFO - Output received: 12:11:25 INFO - /builds/slave/test/build/application/firefox/firefox 12:11:25 INFO - Running post-action listener: _resource_record_post_action 12:11:25 INFO - [mozharness: 2017-10-02 19:11:25.329129Z] Finished install step (success) 12:11:25 INFO - [mozharness: 2017-10-02 19:11:25.329389Z] Running setup-mitmproxy step. 12:11:25 INFO - Running pre-action listener: _resource_record_pre_action 12:11:25 INFO - Running main action method: setup_mitmproxy 12:11:25 INFO - Skipping: mitmproxy is not required 12:11:25 INFO - Running post-action listener: _resource_record_post_action 12:11:25 INFO - [mozharness: 2017-10-02 19:11:25.330536Z] Finished setup-mitmproxy step (success) 12:11:25 INFO - [mozharness: 2017-10-02 19:11:25.330756Z] Running run-tests step. 12:11:25 INFO - Running pre-action listener: _resource_record_pre_action 12:11:25 INFO - Running pre-action listener: _set_gcov_prefix 12:11:25 INFO - Running main action method: run_tests 12:11:25 WARNING - Try message not found. 12:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:11:25 INFO - Python 2.7.3 12:11:25 INFO - Return code: 0 12:11:25 INFO - grabbing minidump binary from tooltool 12:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1addd60>, '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 0x1adea60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1adeef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:11:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:11:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:11:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:11:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:11:25 INFO - Return code: 0 12:11:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:11:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:11:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:11:25 INFO - ENV: RUST_BACKTRACE is now full 12:11:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:11:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:11:25 INFO - Using env: {'DISPLAY': ':0', 12:11:25 INFO - 'HOME': '/home/cltbld', 12:11:25 INFO - 'LANG': 'en_US.UTF-8', 12:11:25 INFO - 'LANGUAGE': 'en_US:en', 12:11:25 INFO - 'LOGNAME': 'cltbld', 12:11:25 INFO - 'MAIL': '/var/mail/cltbld', 12:11:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:25 INFO - 'MOZ_NO_REMOTE': '1', 12:11:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:25 INFO - 'NO_EM_RESTART': '1', 12:11:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:25 INFO - 'PWD': '/builds/slave/test', 12:11:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:25 INFO - 'RUST_BACKTRACE': 'full', 12:11:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:11:25 INFO - 'SHELL': '/bin/bash', 12:11:25 INFO - 'SHLVL': '1', 12:11:25 INFO - 'TERM': 'linux', 12:11:25 INFO - 'TMOUT': '86400', 12:11:25 INFO - 'USER': 'cltbld', 12:11:25 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:25 INFO - '_': '/tools/buildbot/bin/python'} 12:11:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:11:25 INFO - mozversion application_buildid: 20171002174652 12:11:25 INFO - mozversion application_changeset: 15f221f491f707b1e8e46da344b6dd5a394b1242 12:11:25 INFO - mozversion application_display_name: FirefoxNightly 12:11:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:11:25 INFO - mozversion application_name: Firefox 12:11:25 INFO - mozversion application_remotingname: firefox 12:11:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:11:25 INFO - mozversion application_vendor: Mozilla 12:11:25 INFO - mozversion application_version: 58.0a1 12:11:25 INFO - mozversion platform_buildid: 20171002174652 12:11:25 INFO - mozversion platform_changeset: 15f221f491f707b1e8e46da344b6dd5a394b1242 12:11:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:11:25 INFO - mozversion platform_version: 58.0a1 12:11:25 INFO - using testdate: 1506971485 12:11:25 INFO - actual date: 1506971485 12:11:25 INFO - starting webserver on 'localhost:45138' 12:11:25 INFO - SUITE-START | Running 2 tests 12:11:25 INFO - TEST-START | dromaeo_css 12:11:25 INFO - Initialising browser for dromaeo_css test... 12:11:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45138/getInfo.html -profile /tmp/tmprFClFL/profile 12:11:25 INFO - TEST-INFO | started process 24597 (/builds/slave/test/build/application/firefox/firefox http://localhost:45138/getInfo.html) 12:11:31 INFO - TEST-INFO | 24597: exit 0 12:11:31 INFO - Browser initialized. 12:11:31 INFO - Running cycle 1/1 for dromaeo_css test... 12:11:31 INFO - Using env: {'DISPLAY': ':0', 12:11:31 INFO - 'HOME': '/home/cltbld', 12:11:31 INFO - 'JSGC_DISABLE_POISONING': '1', 12:11:31 INFO - 'LANG': 'en_US.UTF-8', 12:11:31 INFO - 'LANGUAGE': 'en_US:en', 12:11:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:11:31 INFO - 'LOGNAME': 'cltbld', 12:11:31 INFO - 'MAIL': '/var/mail/cltbld', 12:11:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:11:31 INFO - 'MOZ_CRASHREPORTER': '1', 12:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:11:31 INFO - 'MOZ_NO_REMOTE': '1', 12:11:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:31 INFO - 'NO_EM_RESTART': '1', 12:11:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:31 INFO - 'PWD': '/builds/slave/test', 12:11:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:31 INFO - 'RUST_BACKTRACE': 'full', 12:11:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:11:31 INFO - 'SHELL': '/bin/bash', 12:11:31 INFO - 'SHLVL': '1', 12:11:31 INFO - 'STYLO_FORCE_DISABLED': '1', 12:11:31 INFO - 'TERM': 'linux', 12:11:31 INFO - 'TMOUT': '86400', 12:11:31 INFO - 'USER': 'cltbld', 12:11:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:31 INFO - '_': '/tools/buildbot/bin/python'} 12:11:31 INFO - TEST-INFO | started process 24836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprFClFL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:32 INFO - PID 24836 | 12:11:32 INFO - PID 24836 | (/builds/slave/test/build/application/firefox/firefox:24886): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:11:32 INFO - PID 24836 | 12:11:42 INFO - PID 24836 | RSS: Main: 145453056 12:11:42 INFO - PID 24836 | 12:14:39 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45138/tests/dromaeo/cssquery-ext.html) 12:14:40 INFO - PID 24836 | RSS: Main: 143433728 12:14:40 INFO - PID 24836 | 12:17:42 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-ext.html (next: http://localhost:45138/tests/dromaeo/cssquery-jquery.html) 12:17:43 INFO - PID 24836 | RSS: Main: 141475840 12:17:43 INFO - PID 24836 | 12:20:44 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45138/tests/dromaeo/cssquery-mootools.html) 12:20:45 INFO - PID 24836 | RSS: Main: 145805312 12:20:45 INFO - PID 24836 | 12:23:46 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45138/tests/dromaeo/cssquery-prototype.html) 12:23:47 INFO - PID 24836 | RSS: Main: 145113088 12:23:47 INFO - PID 24836 | 12:26:50 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45138/tests/dromaeo/cssquery-yui.html) 12:26:51 INFO - PID 24836 | RSS: Main: 148135936 12:26:51 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | Cycle 1(1): loaded http://localhost:45138/tests/dromaeo/cssquery-yui.html (next: http://localhost:45138/tests/dromaeo/cssquery-dojo.html) 12:29:52 INFO - PID 24836 | RSS: Main: 147353600 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | __start_tp_report 12:29:52 INFO - PID 24836 | _x_x_mozilla_page_load 12:29:52 INFO - PID 24836 | _x_x_mozilla_page_load_details 12:29:52 INFO - PID 24836 | |i|pagename|runs| 12:29:52 INFO - PID 24836 | |0;dojo.html;3832.06114501947;3915.432262321963;3939.0940083780747;3946.605339466054;3961.9405708914373;6257.968710156443;6317.684115794209;6372.936270637292;6454;6487.221533415991;6313.873722525546;6365.204349456307;6409.23089229292;6509.73961041559;6532.967335163317;5685.630434021796;5788.768449262025;5792.826215213529;5799.333076696192;5814.825555233349;126.88271382513574;5532.944670553304;5702.344230413514;5708.714564271791;5795.768169273224;5717.313922329306;5727.284089488814;5729.742161602738;5755.568332375067;5800.897829412398;5707.971460142673;5725.627834190765;5784.508316793078;5799.159121927297;5800.071988481823;5712.742926568314;5759.856003599902;5779.1620215069;5780.1907732917425;5781.797637082682;6304.747810087591;6347.301796802348;6371.203599550056;6439.613623182624;6439.839004024937;6781.321867813179;6805.523613347068;6928.792136235921;6958.721651133948;7009.474289428314;7036.859262814715;7096.325849044332;7103.467239957024;7104.325089116525;7110.7511237106455;6413.6793160341795;6469.644169570624;6479.967600162016;6485.189351331083;6546.149000629887;7063.223045464994;7153.141623005168;7161.104861892263;7209.846424572043;7219.278072192738;6796.8300792479595;6810.6254156020905;6899.75850845218;6901.344372284725;6905.689243984033;6889.931100688929;6935.6878940447805;6953.408960238336;7025.613591252531;7052.118485189351;6950.582965022115;6953;6969.30306969299;6971.3028697129885;6999.265077166926;6827.965860170667;6974.686139123752;6982.546134501241;7009.754658586925;7015.754448594377;5028.321176641107;5073.619478539051;5081.5426611605135;5099.413567439792;5099.8725031873755;4562.08758248345;4566.200914839957;4610.147122782296;4610.654200934943;4622.930656040162;6358.777442789573;6409.455196308366;6416.903746443807;6417.807465776034;6420.1974753155855;6872.62200578963;6975.197852246955;6976.651167441608;7021.192562855234;7029.824254393681;6331.936680633226;6427.325130861286;6432.935670643327;6467.353264673495;6472.288048314682;5578.191162281528;5592.608517403824;5654.46282603152;5675.3757086720425;5680.715964201773;7142.607156606437;7231.638418079075;7235.565866048054;7242.275772422821;7246.891296630555;6858.074159988338;6908.481863860331;6908.9309106909295;6945.16658001033;6980.860382792417;7257.637118143966;7296.963515182602;7308.634568271672;7310;7312.268773122645;6871.209810871814;6894.655267236719;6897.827554311182;6999.230084690578;7003.5797852129035;6899;6963.4777391694815;6975.267596902252;7017.403520700797;7052.541584796972;6709.329067093252;6720.395164435029;6725.19297684281;6728.428083612947;6752.729890804313;6669.799906002828;6719.092922455406;6753.831154221184;6781.38967492928;6791.3548212919695;6601.768938087336;6610.570312929644;6682.599044057372;6684.197896252481;6684.398404143651;6704.66476676174;6736.056952026818;6738.494612903954;6807.795766127024;6847.863042739217;6563.671816409065;6571.901421478778;6574.704138313883;6577.473802095725;6592.670366481752 12:29:52 INFO - PID 24836 | |1;ext.html;971.6210677835643;997.1424574865616;997.8104160209559;998.8152191844514;1009.2834087797663;45261;46367.30449043267;46409.53590464099;46454.767726161364;46599.301010484785;43237.35143972843;43457.348139777925;43632.12735745283;43635.78182109093;43681.781591092076;7509.286617771303;7579.431542634297;7580.128285247212;7580.507267027653;7581.734639287626;7563.470557061008;7650.464467487278;7668.693252269931;7690.346320562759;7713.267239612228;7647.808804779897;7688.961555192244;8512.616932238065;8677.479351238915;8712.303015758724;8561.44350617208;8632.784180395478;8634.481931084156;8634.827303453958;8644.049154592989;8279;8455.661773529051;8496.447730897533;8581.957090214572;8604.82790344196;42791.57208427907;43237;43265;43274.350884736756;43288.56711432877;3735.3276410246144;3736.23407201523;3765.3975363941636;3786.167043250508;3787.0910981364273;34735.131621709406;34997.82501087478;35043;35090.12274693127;35128.47307290393;5410.3507579090365;5446.754896029688;5461.0716178249395;5461.453854614547;5477.643953143033;226690;227165;227813.99999999834;227841;229107;49289.75355123202;50352.49647503478;56292.718536407054;56441;57293.427065729644;59197;59250;59257.70371148117;59469.40530594725;59502;17500.124993750516;17769.644607107784;17792.37726679586;17812.287508499776;17830.10849457522;13427;13466;13522.93238533801;13669.726605467835;13722.245276509688;16146.111963841866;16153.838461615469;16177.19114044293;16226.107564083854;16278.104704241143;5881.558883083786;6053.7578496860515;6165.537584681167;6198.008318668992;6316.557840951089;1085.180688580117;1088.5373716170595;1091.5742860284495;1103.7902798468265;1114.3481063577735;25222.369440764127;25394.619080713805;25475.61786573203;25480.362990925376;25687.229383118538;1196.3719047499958;1198.6044605280238;1206.1014544164477;1221.9511219551296;1223.3883058470765;13601.31993400326;13764.31178441074;13808.930955345159;13845.930770346084;13858.930705346409;305172;306831;306837;307095;307214;62884.68557657274;63302.68348658319;63491;63516;63613;1499.3702644889172;1506.683596444759;1517.1276516003122;1534.9309281082378;1545.127003243164;25583.488330233664;25666;25752;25787.484250314512;25892;43912.34131487966;44072.55927440813;44088.77955610202;44130.33804492871;44152;243394;245610;246541;246753;248945;38336.80831595824;38394.42408363821;41106;41558.37662435006;41573;50485.49514504808;52021.47978520166;52369.738151309;52478.47521524736;52757.208641869634;37798.43302350522;38270;38307;38439.423408648334;38539.42190867083;36588.26823463569;36822.631773682995;36864.63135368612;37487.62512374841;37551;43377.132457351305;45263.77368113138;45335.54664453313;45487.77256113698;45500;36453.81773091118;36491.63508364988;36625.63374366329;36758.44862327121;36945;26863.731362686904;27284.454310913272;27293;27658.308542286602;27877.37540337016 12:29:52 INFO - PID 24836 | |2;jquery.html;608.8599622086919;617.5677026081742;619.3682443907214;621.468644309116;630.5586089737185;23509.29472115837;23609.055637774512;23997.520049599;24136.517269654596;24161.999999999978;26137.301075430085;26667.866660666718;27030.5945410819;27039.188824335302;27052.864735676296;6625.734970601182;6767.255601883813;6793.7961861143995;6793.966030169842;6795;6586.275509693954;6607.735690572371;6676.599404035774;6865.382115609594;6898.448124150056;6783.491238157158;6818.897716534256;6852.074969879052;6861.691223894937;6873.17521897373;6672.699728512229;6799.388055075042;6860.348266914635;6940.826479338007;6954.200266969313;6467.676616169173;6468.964965605527;6475.967620161869;6493.51298652603;6538.476921846241;30535.69464305373;30799.692003079905;30964.8451757742;31032;31065.37869242625;2153.6877152812913;2174.239016344283;2180.6401943679275;2192.8136108430804;2195.0451553574085;20360.389188324374;21949.231776887893;22030.449238768997;22081.668774968388;22083.33749987503;2588.8576128312934;2606.126947472599;2646.4442467081935;2646.6559347284924;2669.9599506007426;145397;149737;152403;157326.21336893243;157431.2128439362;15951.680966380607;16407.507774766775;16776.664466710597;16864.39788220117;16960.236789344508;26850.194494165207;26907.327316817235;27040.32399190036;27129;27159.592606110924;8725.389222754346;8940.46357218556;9045.050269721585;9156.404833685789;9183.954080229556;7550.169481357047;7629.809254768676;7643.312101910855;7693.730719424793;7721;10197.74505637365;10205.642802502025;10225.233107516966;10302;10341.896581034243;2809.1572528241445;2809.845458499802;2861.0129505320633;2890.147406515041;2981.552767084911;874.6807415293372;895.3508706187962;895.7088946092546;907.8365894139118;911.1799380557419;19331.710024349646;19825.801741982683;19928.800711992986;19948.70076948847;20351.796482035286;947.5593848860314;948.7248697877676;954.0983770336965;956.9569369378395;961.4615815143402;10461.581536738597;10636.095931845724;10707.304025238334;10781.514831832586;10956.561737530568;577239;590256;596475;602387;604485;126648.36675816562;126774.36612817062;128447;128911;130102.34948825196;1105.4307031878589;1167.4804711903291;1198.2451055834943;1206.3304865799566;1249.2504497301727;22365.440863978532;22612.434689132904;22643.43391415228;22698.205562805222;22723.659145112506;59872;60911.39088609057;61979;63281.99999999816;63383;77510.61244693966;78605.60697196478;78732;78966;79404;15907.920460397623;15974.361025558848;16038.67922641564;16161.030338179748;16331.510054698378;21937.122515099218;22193.66709499391;22265.888670556542;23006.07975681021;24218.75781242165;17916.193771280585;18738;18744.250229991194;18926.810731892503;18950.0524973748;16174.757378639095;16304;16659.250333735254;16674.66650667004;16718.916405417895;18687.532811679815;20085.899570502053;20213.494662632962;20380.898095509427;20435.693464598342;16012.519624411287;16142.273597687898;16155.27301271422;16178.110203938897;16181.838181618034;17731.911340443214;18294.176762045474;18321;18465.261389544266;18484 12:29:52 INFO - PID 24836 | |3;mootools.html;1457.766757318829;1493.6041948883542;1498.1161114942188;1534.3785766764465;1539.7690346448035;16606.16969151542;17131.143442827855;17188;17265.482035538924;17336.82663173368;17318.653626927455;17879.73180402295;17899.28402863887;17916.55208619785;17966.64066718665;2805.8877644894233;2845.502037143502;2852.3724780548246;2852.62915820943;2853.743163115319;2721.4965231432147;2742.7394397532203;2742.8765705543196;2841.1618572521156;2841.8152820066734;2816.3663175785387;2848.9287767805868;2849.1167738001286;2852.472292625871;2853.7146285371505;2713.2402927180324;2737.890484380622;2754.3664957059987;2756.5589505679095;2763.101991852646;2712.1185614675114;2758.2966343582457;2759.696433392325;2760.0477835146844;2798.776097912162;16806.24371903255;16906.915465422717;16979.49061528156;16984.915075424542;16986;8251.917480825176;8507.787305317355;8527.275181609508;8532.445391049561;8543.231109200202;5394.676319420847;5526.226328314039;5710.14347847822;5716.1711551825165;5716.485516303511;1981.9108140133585;2034.4201902457728;2058.125296748876;2082.72924519813;2096.056774451503;31168.37663246745;31595.36809263802;31598.36803263945;31613.84193079043;32435.51346729801;7274.781756547312;7283.162436319785;7350.485466017328;7429.665665045086;7553.357964572963;20749.27377541809;20928.581428371654;21050.894745526482;21061.89469052645;21073.157073717186;8336.416450848383;8554.18735220153;8565.186307300797;8568.914310856811;8581.313494920516;7525.698972041167;7545.170031296553;7598.278163574451;7664.34853037498;7688.077430708351;5601.579881508822;5802.593818432669;5849.444302791228;5912.586118971717;5913.763449461973;1579.7314456542415;1610.5409958161868;1729.1267909705518;1757.1038770227276;1768.6639538487645;954.236610711428;966.4539535162751;976.2239019978991;977.4330888084894;982.5283863745442;9184.586693598803;9248.445093294424;9249.768755781159;9251.306152038489;9338.206252468617;1060.2154405739698;1081.967540973772;1090.2095980414294;1095.7151140703315;1099.9010089092021;5567.944320556823;5614.553145217264;5628.915566266509;5675.858103547362;5853.560982926298;24258.757412426003;25331.87334063355;26430;26806.865965670437;26853.194404167905;25863.61204581933;25998.6100208497;26022.479550409265;26262;26322.47355052888;12752.617421477371;12872;13000.609981700374;13036;13112.541061063008;9077.954610226907;9195.126462986005;9216.861747073934;9222.985471598253;9431.151196392357;21550.461238469165;21740.45648858728;21898.781012189673;22115.33653990383;22604.095836167027;22710.545789084455;22835.657465137705;22855.20006799754;23177.768222318235;23324.76675233226;13141.802872956721;13272.80090798658;13397.397117129947;13414.061015728805;13418.127821691558;15955;15965.920170399073;16004.599885002503;16156.757648635044;16179.11014894145;12846.421911014213;13170.341482926007;13340.733185336432;13444.193348399127;13446.663833404244;12640.30478323701;12759;12780.744385112432;12814.935925320313;13253.469861205444;10330.535125919201;10385.84421233667;10494.947525262325;10507.78984420292;10529.420881851265;7723.459357844897;7778.533288002738;7813.882791758242;7823.3350165234315;8006.1993800619475;8274.544900030556;8308.33533317321;8319.126491718282;8377.162283771575;8383.329333653415 12:29:52 INFO - PID 24836 | |4;prototype.html;557.385860315122;568.5530325322055;583.4165834165834;591.7455494137521;604.8155312629649;6378.330275321094;6427.389398007193;6432.742690292389;6465.224173099235;6480.675966201688;6309.30597634261;6310;6317.431431171193;6330.398612131851;6340.714667839947;5232.215167724834;5234.162533994552;5240.240165176047;5241.606879484035;5251.2385704072885;4883.9755801220945;5076.720780357079;5193.143131383317;5267.815626453075;5271.103912334893;5053.620978426614;5097.286379906816;5103.540681338679;5130;5152.407473140599;5066.493350664941;5099.719515426668;5103.56619687327;5111.974440127794;5114;4627.6529260305615;4630.675852690313;4634.814607415699;4646.932115208733;4668.486466488684;6285.402886725754;6300.369963003663;6309.684515774239;6327.27236367819;6332.841678958017;5968.7612495500125;6075.48358389533;6087.208662873798;6104.908426373608;6108.205933228652;6668.899966500507;6669.499787515956;6731.326867313279;6834.555753876032;6835.897461538081;5008.373953255843;5165.276861239429;5193.948060519384;5199.168133098686;5212.322398088262;6794.422474089659;6941.479389045841;6977.93022069783;7030.824229394255;7081.645917704146;5312.946870531323;5330.333708286465;5339.492748188916;5350.866228344323;5378.542823860016;5365.168398898177;5392.676439413648;5421.403645598981;5428.972855135778;5482.396936337;5951.226340575698;5998.190244316961;6031.698415079229;6071.150038994544;6072.483838873745;6816.897746533806;6848.417884479875;6856.931430685729;6879.759208427681;6919.757808476679;1845.4463660901677;1872.2978882918906;1875.4186202277338;1885.5858106420185;1891.6784146695095;1305.2299143505377;1320.9933950330378;1330.940107695156;1349.3740043247863;1356.2269506381465;6190.845228869224;6209.285932117864;6238.906416403757;6239.221821780861;6240.937590624036;6684.328917770557;6715.623297224058;6752.696128674222;6841.760538381232;6858.554193977376;6033.607815491979;6122.816315510542;6228.875422491525;6294.622322660655;6312.621242725451;3574.392353299945;3636.890893273206;3645.3231513504084;3658.926821463556;3659.14010207601;7047.674267491715;7128;7158.2125966143685;7181.317774811385;7203;7012.684429200596;7090.468214883801;7093.333066729315;7093.574385536885;7102.792525270716;7078.292170782881;7117.928820711727;7119.8932016020835;7161.856762864713;7182.892256616155;6836.145481814773;6856.5200435969;6870.931290687229;6890.896636550356;6976.965115174392;6802.14973128359;6818.488613353919;6823.317668233137;6839.794806155824;6851.657417129024;7042.577445353295;7047.541909775849;7066.505344625827;7096.964515177391;7115.2884711530505;5324.43263013774;5342.98483288174;5352.0366334060245;5353.625246232882;5379.757910893941;6651.769422656824;6663.900456424635;6818.488613354118;6842.349976752201;6847.986885770245;6215;6545.541812073109;6649.570342376219;6670.83322916931;6693.19681638187;6631.867362652816;6651.968944813561;6662.666866656551;6697.498801342527;6713.61666608347;6491.188601424822;6502.219733631994;6524.934750652623;6576.408123268929;6581;6700.688262549413;6742.415532349796;6747.156605424322;6772.458203343819;6797.830054248683;6496.545241833026;6542.607443553402;6558.737650493927;6567.770128045687;6607.702653380513 12:29:52 INFO - PID 24836 | |5;yui.html;961.8172547216024;984.1880448629881;994.5275993902897;1001.7796084861328;1004.2217281606754;18628.441146765585;19386.806131938694;19390.4182874514;19457.610847783035;19836.9008154959;19574.608507829835;19825.504362390948;19909.40271791845;19909.701354479694;19913.303034393764;1027.0961553832635;1049.522467277387;1049.7900419916048;1050.8581341518911;1051.7528380830538;1062.1874266186373;1063.2716589136428;1066.0831684751108;1066.7813098314828;1067;1056.1392465140887;1091.045335331585;1091.8307662312354;1125.071815752008;1128.9943550282278;1070.1064611049783;1082.870055593326;1083.6803143072812;1084.4957094950885;1085.0505807418508;783.3419927261128;783.9490433121829;790.4111436979487;792.1088775127981;797.5772840394542;20134.79865201344;20188.596228075505;20305.390838274874;20307.89846050775;20387.08258128373;22778.974946127462;23148.42128946773;23160.76839231603;23654.172103976278;23670.289891303288;18203.18085686134;18290.08549572516;18454.44636660889;18642;18664.533386665444;3975.1254723960683;3977.840886364542;4008.518977722663;4018.7588744675413;4023.2154729827694;142289.2885535576;172402.99999999875;175082;177161;179399;19067.237310507702;19195.80804191968;19295.324663636704;19306.42080737552;19316.420507384802;33242.3351532968;34977.65022349744;35109.64890351115;35194.47208291878;35315.293694126485;9594.136527712539;9705.223582113415;9796.804063918682;9892.208623310118;9931.702048938543;4502.707324023928;4532.886677833015;4543.818247270138;4582.266837306015;4590.770461476913;5934.991051521251;6054.091886217103;6134.38656134383;6153.4154255345675;6199.752009919643;1168.9824652630218;1178.4637989714658;1193.7493126443544;1198.0415667465993;1205.3551350027692;676.3473248315399;707.1973310292752;709.1419382547073;711.2247650061355;715.860407220587;12049.698757531132;12298.692532686755;12544.623661290176;12626.684332891567;12712.491500339884;655.0828839624563;663.3830537600078;667.4460198035619;671.4628297362091;679.5616827146463;5714.942850571524;5783.971080144656;5849.853753656193;5875.324337701134;5939.4951429129005;160145;162736;162769;163983;166089;141369;141963.29018355047;142363;144606.2769686145;145843;121106.3944680271;121444;123336.38331808284;125149;127476.36261818632;10810.29733067348;10829.429732688559;10902.50938707776;10967;11145.832812507657;58040.4195958035;58823.41176588179;59455;59512.10731838939;59749.70125149346;70548.29451705418;72289.6385518069;72457;73061.6346918262;76250;17467.650646987244;17565.12174391301;17571.472855814347;17624.29502819873;17797.288108476034;17697.292108315523;18110.456686299432;18327.63344733071;18333.449996500127;18460.723089153405;16399.42602008924;16426.917865410596;16431.753523697393;16446.75329870029;16455.917720411322;18417.723734143732;18480;18549.629007419506;18580.070996449853;18619.906900465412;16639.66720665556;16909.577260568585;16939.745903811698;16952.152392380085;17013.319467221172;11386.089112870784;11705.180637355303;11898;12052;12124;12287.201331913397;12424.813627795409;12530.37348132608;12623.789530372793;12758.48966041348 12:29:52 INFO - PID 24836 | __end_tp_report 12:29:52 INFO - PID 24836 | __start_cc_report 12:29:52 INFO - PID 24836 | _x_x_mozilla_cycle_collect,272 12:29:52 INFO - PID 24836 | __end_cc_report 12:29:52 INFO - PID 24836 | __startTimestamp1506972592781__endTimestamp 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | ------- Summary: start ------- 12:29:52 INFO - PID 24836 | Number of tests: 6 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#0] dojo.html Cycles:165 Average:6365.14 Median:6669.80 stddev:913.07 (13.7%) stddev-sans-first:893.99 12:29:52 INFO - PID 24836 | Values: 3832.1 3915.4 3939.1 3946.6 3961.9 6258.0 6317.7 6372.9 6454.0 6487.2 6313.9 6365.2 6409.2 6509.7 6533.0 5685.6 5788.8 5792.8 5799.3 5814.8 126.9 5532.9 5702.3 5708.7 5795.8 5717.3 5727.3 5729.7 5755.6 5800.9 5708.0 5725.6 5784.5 5799.2 5800.1 5712.7 5759.9 5779.2 5780.2 5781.8 6304.7 6347.3 6371.2 6439.6 6439.8 6781.3 6805.5 6928.8 6958.7 7009.5 7036.9 7096.3 7103.5 7104.3 7110.8 6413.7 6469.6 6480.0 6485.2 6546.1 7063.2 7153.1 7161.1 7209.8 7219.3 6796.8 6810.6 6899.8 6901.3 6905.7 6889.9 6935.7 6953.4 7025.6 7052.1 6950.6 6953.0 6969.3 6971.3 6999.3 6828.0 6974.7 6982.5 7009.8 7015.8 5028.3 5073.6 5081.5 5099.4 5099.9 4562.1 4566.2 4610.1 4610.7 4622.9 6358.8 6409.5 6416.9 6417.8 6420.2 6872.6 6975.2 6976.7 7021.2 7029.8 6331.9 6427.3 6432.9 6467.4 6472.3 5578.2 5592.6 5654.5 5675.4 5680.7 7142.6 7231.6 7235.6 7242.3 7246.9 6858.1 6908.5 6908.9 6945.2 6980.9 7257.6 7297.0 7308.6 7310.0 7312.3 6871.2 6894.7 6897.8 6999.2 7003.6 6899.0 6963.5 6975.3 7017.4 7052.5 6709.3 6720.4 6725.2 6728.4 6752.7 6669.8 6719.1 6753.8 6781.4 6791.4 6601.8 6610.6 6682.6 6684.2 6684.4 6704.7 6736.1 6738.5 6807.8 6847.9 6563.7 6571.9 6574.7 6577.5 6592.7 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#1] ext.html Cycles:180 Average:44972.54 Median:38416.92 stddev:68338.39 (177.9%) stddev-sans-first:68450.24 12:29:52 INFO - PID 24836 | Values: 971.6 997.1 997.8 998.8 1009.3 45261.0 46367.3 46409.5 46454.8 46599.3 43237.4 43457.3 43632.1 43635.8 43681.8 7509.3 7579.4 7580.1 7580.5 7581.7 7563.5 7650.5 7668.7 7690.3 7713.3 7647.8 7689.0 8512.6 8677.5 8712.3 8561.4 8632.8 8634.5 8634.8 8644.0 8279.0 8455.7 8496.4 8582.0 8604.8 42791.6 43237.0 43265.0 43274.4 43288.6 3735.3 3736.2 3765.4 3786.2 3787.1 34735.1 34997.8 35043.0 35090.1 35128.5 5410.4 5446.8 5461.1 5461.5 5477.6 226690.0 227165.0 227814.0 227841.0 229107.0 49289.8 50352.5 56292.7 56441.0 57293.4 59197.0 59250.0 59257.7 59469.4 59502.0 17500.1 17769.6 17792.4 17812.3 17830.1 13427.0 13466.0 13522.9 13669.7 13722.2 16146.1 16153.8 16177.2 16226.1 16278.1 5881.6 6053.8 6165.5 6198.0 6316.6 1085.2 1088.5 1091.6 1103.8 1114.3 25222.4 25394.6 25475.6 25480.4 25687.2 1196.4 1198.6 1206.1 1222.0 1223.4 13601.3 13764.3 13808.9 13845.9 13858.9 305172.0 306831.0 306837.0 307095.0 307214.0 62884.7 63302.7 63491.0 63516.0 63613.0 1499.4 1506.7 1517.1 1534.9 1545.1 25583.5 25666.0 25752.0 25787.5 25892.0 43912.3 44072.6 44088.8 44130.3 44152.0 243394.0 245610.0 246541.0 246753.0 248945.0 38336.8 38394.4 41106.0 41558.4 41573.0 50485.5 52021.5 52369.7 52478.5 52757.2 37798.4 38270.0 38307.0 38439.4 38539.4 36588.3 36822.6 36864.6 37487.6 37551.0 43377.1 45263.8 45335.5 45487.8 45500.0 36453.8 36491.6 36625.6 36758.4 36945.0 26863.7 27284.5 27293.0 27658.3 27877.4 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#2] jquery.html Cycles:180 Average:39322.55 Median:2597.49 stddev:99552.49 (3832.6%) stddev-sans-first:99789.33 12:29:52 INFO - PID 24836 | Values: 608.9 617.6 619.4 621.5 630.6 23509.3 23609.1 23997.5 24136.5 24162.0 26137.3 26667.9 27030.6 27039.2 27052.9 6625.7 6767.3 6793.8 6794.0 6795.0 6586.3 6607.7 6676.6 6865.4 6898.4 6783.5 6818.9 6852.1 6861.7 6873.2 6672.7 6799.4 6860.3 6940.8 6954.2 6467.7 6469.0 6476.0 6493.5 6538.5 30535.7 30799.7 30964.8 31032.0 31065.4 2153.7 2174.2 2180.6 2192.8 2195.0 20360.4 21949.2 22030.4 22081.7 22083.3 2588.9 2606.1 2646.4 2646.7 2670.0 145397.0 149737.0 152403.0 157326.2 157431.2 15951.7 16407.5 16776.7 16864.4 16960.2 26850.2 26907.3 27040.3 27129.0 27159.6 8725.4 8940.5 9045.1 9156.4 9184.0 7550.2 7629.8 7643.3 7693.7 7721.0 10197.7 10205.6 10225.2 10302.0 10341.9 2809.2 2809.8 2861.0 2890.1 2981.6 874.7 895.4 895.7 907.8 911.2 19331.7 19825.8 19928.8 19948.7 20351.8 947.6 948.7 954.1 957.0 961.5 10461.6 10636.1 10707.3 10781.5 10956.6 577239.0 590256.0 596475.0 602387.0 604485.0 126648.4 126774.4 128447.0 128911.0 130102.3 1105.4 1167.5 1198.2 1206.3 1249.3 22365.4 22612.4 22643.4 22698.2 22723.7 59872.0 60911.4 61979.0 63282.0 63383.0 77510.6 78605.6 78732.0 78966.0 79404.0 15907.9 15974.4 16038.7 16161.0 16331.5 21937.1 22193.7 22265.9 23006.1 24218.8 17916.2 18738.0 18744.3 18926.8 18950.1 16174.8 16304.0 16659.3 16674.7 16718.9 18687.5 20085.9 20213.5 20380.9 20435.7 16012.5 16142.3 16155.3 16178.1 16181.8 17731.9 18294.2 18321.0 18465.3 18484.0 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#3] mootools.html Cycles:180 Average:10704.26 Median:2712.68 stddev:8085.69 (298.1%) stddev-sans-first:8078.53 12:29:52 INFO - PID 24836 | Values: 1457.8 1493.6 1498.1 1534.4 1539.8 16606.2 17131.1 17188.0 17265.5 17336.8 17318.7 17879.7 17899.3 17916.6 17966.6 2805.9 2845.5 2852.4 2852.6 2853.7 2721.5 2742.7 2742.9 2841.2 2841.8 2816.4 2848.9 2849.1 2852.5 2853.7 2713.2 2737.9 2754.4 2756.6 2763.1 2712.1 2758.3 2759.7 2760.0 2798.8 16806.2 16906.9 16979.5 16984.9 16986.0 8251.9 8507.8 8527.3 8532.4 8543.2 5394.7 5526.2 5710.1 5716.2 5716.5 1981.9 2034.4 2058.1 2082.7 2096.1 31168.4 31595.4 31598.4 31613.8 32435.5 7274.8 7283.2 7350.5 7429.7 7553.4 20749.3 20928.6 21050.9 21061.9 21073.2 8336.4 8554.2 8565.2 8568.9 8581.3 7525.7 7545.2 7598.3 7664.3 7688.1 5601.6 5802.6 5849.4 5912.6 5913.8 1579.7 1610.5 1729.1 1757.1 1768.7 954.2 966.5 976.2 977.4 982.5 9184.6 9248.4 9249.8 9251.3 9338.2 1060.2 1082.0 1090.2 1095.7 1099.9 5567.9 5614.6 5628.9 5675.9 5853.6 24258.8 25331.9 26430.0 26806.9 26853.2 25863.6 25998.6 26022.5 26262.0 26322.5 12752.6 12872.0 13000.6 13036.0 13112.5 9078.0 9195.1 9216.9 9223.0 9431.2 21550.5 21740.5 21898.8 22115.3 22604.1 22710.5 22835.7 22855.2 23177.8 23324.8 13141.8 13272.8 13397.4 13414.1 13418.1 15955.0 15965.9 16004.6 16156.8 16179.1 12846.4 13170.3 13340.7 13444.2 13446.7 12640.3 12759.0 12780.7 12814.9 13253.5 10330.5 10385.8 10494.9 10507.8 10529.4 7723.5 7778.5 7813.9 7823.3 8006.2 8274.5 8308.3 8319.1 8377.2 8383.3 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#4] prototype.html Cycles:180 Average:5745.14 Median:6315.03 stddev:1589.31 (25.2%) stddev-sans-first:1545.33 12:29:52 INFO - PID 24836 | Values: 557.4 568.6 583.4 591.7 604.8 6378.3 6427.4 6432.7 6465.2 6480.7 6309.3 6310.0 6317.4 6330.4 6340.7 5232.2 5234.2 5240.2 5241.6 5251.2 4884.0 5076.7 5193.1 5267.8 5271.1 5053.6 5097.3 5103.5 5130.0 5152.4 5066.5 5099.7 5103.6 5112.0 5114.0 4627.7 4630.7 4634.8 4646.9 4668.5 6285.4 6300.4 6309.7 6327.3 6332.8 5968.8 6075.5 6087.2 6104.9 6108.2 6668.9 6669.5 6731.3 6834.6 6835.9 5008.4 5165.3 5193.9 5199.2 5212.3 6794.4 6941.5 6977.9 7030.8 7081.6 5312.9 5330.3 5339.5 5350.9 5378.5 5365.2 5392.7 5421.4 5429.0 5482.4 5951.2 5998.2 6031.7 6071.2 6072.5 6816.9 6848.4 6856.9 6879.8 6919.8 1845.4 1872.3 1875.4 1885.6 1891.7 1305.2 1321.0 1330.9 1349.4 1356.2 6190.8 6209.3 6238.9 6239.2 6240.9 6684.3 6715.6 6752.7 6841.8 6858.6 6033.6 6122.8 6228.9 6294.6 6312.6 3574.4 3636.9 3645.3 3658.9 3659.1 7047.7 7128.0 7158.2 7181.3 7203.0 7012.7 7090.5 7093.3 7093.6 7102.8 7078.3 7117.9 7119.9 7161.9 7182.9 6836.1 6856.5 6870.9 6890.9 6977.0 6802.1 6818.5 6823.3 6839.8 6851.7 7042.6 7047.5 7066.5 7097.0 7115.3 5324.4 5343.0 5352.0 5353.6 5379.8 6651.8 6663.9 6818.5 6842.3 6848.0 6215.0 6545.5 6649.6 6670.8 6693.2 6631.9 6652.0 6662.7 6697.5 6713.6 6491.2 6502.2 6524.9 6576.4 6581.0 6700.7 6742.4 6747.2 6772.5 6797.8 6496.5 6542.6 6558.7 6567.8 6607.7 12:29:52 INFO - PID 24836 | 12:29:52 INFO - PID 24836 | [#5] yui.html Cycles:180 Average:29467.25 Median:18470.36 stddev:45710.88 (247.5%) stddev-sans-first:45789.01 12:29:52 INFO - PID 24836 | Values: 961.8 984.2 994.5 1001.8 1004.2 18628.4 19386.8 19390.4 19457.6 19836.9 19574.6 19825.5 19909.4 19909.7 19913.3 1027.1 1049.5 1049.8 1050.9 1051.8 1062.2 1063.3 1066.1 1066.8 1067.0 1056.1 1091.0 1091.8 1125.1 1129.0 1070.1 1082.9 1083.7 1084.5 1085.1 783.3 783.9 790.4 792.1 797.6 20134.8 20188.6 20305.4 20307.9 20387.1 22779.0 23148.4 23160.8 23654.2 23670.3 18203.2 18290.1 18454.4 18642.0 18664.5 3975.1 3977.8 4008.5 4018.8 4023.2 142289.3 172403.0 175082.0 177161.0 179399.0 19067.2 19195.8 19295.3 19306.4 19316.4 33242.3 34977.7 35109.6 35194.5 35315.3 9594.1 9705.2 9796.8 9892.2 9931.7 4502.7 4532.9 4543.8 4582.3 4590.8 5935.0 6054.1 6134.4 6153.4 6199.8 1169.0 1178.5 1193.7 1198.0 1205.4 676.3 707.2 709.1 711.2 715.9 12049.7 12298.7 12544.6 12626.7 12712.5 655.1 663.4 667.4 671.5 679.6 5714.9 5784.0 5849.9 5875.3 5939.5 160145.0 162736.0 162769.0 163983.0 166089.0 141369.0 141963.3 142363.0 144606.3 145843.0 121106.4 121444.0 123336.4 125149.0 127476.4 10810.3 10829.4 10902.5 10967.0 11145.8 58040.4 58823.4 59455.0 59512.1 59749.7 70548.3 72289.6 72457.0 73061.6 76250.0 17467.7 17565.1 17571.5 17624.3 17797.3 17697.3 18110.5 18327.6 18333.4 18460.7 16399.4 16426.9 16431.8 16446.8 16455.9 18417.7 18480.0 18549.6 18580.1 18619.9 16639.7 16909.6 16939.7 16952.2 17013.3 11386.1 11705.2 11898.0 12052.0 12124.0 12287.2 12424.8 12530.4 12623.8 12758.5 12:29:52 INFO - PID 24836 | -------- Summary: end -------- 12:29:52 INFO - PID 24836 | 12:29:53 INFO - TEST-INFO | 24836: exit 0 12:29:53 INFO - TEST-OK | dromaeo_css | took 1107595ms 12:29:53 INFO - TEST-START | kraken 12:29:53 INFO - Initialising browser for kraken test... 12:29:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45138/getInfo.html -profile /tmp/tmpvhgNnK/profile 12:29:53 INFO - TEST-INFO | started process 25196 (/builds/slave/test/build/application/firefox/firefox http://localhost:45138/getInfo.html) 12:29:58 INFO - TEST-INFO | 25196: exit 0 12:29:58 INFO - Browser initialized. 12:29:58 INFO - Running cycle 1/1 for kraken test... 12:29:58 INFO - Using env: {'DISPLAY': ':0', 12:29:58 INFO - 'HOME': '/home/cltbld', 12:29:58 INFO - 'JSGC_DISABLE_POISONING': '1', 12:29:58 INFO - 'LANG': 'en_US.UTF-8', 12:29:58 INFO - 'LANGUAGE': 'en_US:en', 12:29:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:29:58 INFO - 'LOGNAME': 'cltbld', 12:29:58 INFO - 'MAIL': '/var/mail/cltbld', 12:29:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:29:58 INFO - 'MOZ_CRASHREPORTER': '1', 12:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:29:58 INFO - 'MOZ_NO_REMOTE': '1', 12:29:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:58 INFO - 'NO_EM_RESTART': '1', 12:29:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:58 INFO - 'PWD': '/builds/slave/test', 12:29:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:58 INFO - 'RUST_BACKTRACE': 'full', 12:29:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:29:58 INFO - 'SHELL': '/bin/bash', 12:29:58 INFO - 'SHLVL': '1', 12:29:58 INFO - 'STYLO_FORCE_DISABLED': '1', 12:29:58 INFO - 'TERM': 'linux', 12:29:58 INFO - 'TMOUT': '86400', 12:29:58 INFO - 'USER': 'cltbld', 12:29:58 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599', 12:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:58 INFO - '_': '/tools/buildbot/bin/python'} 12:29:58 INFO - TEST-INFO | started process 25434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvhgNnK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:59 INFO - PID 25434 | 12:29:59 INFO - PID 25434 | (/builds/slave/test/build/application/firefox/firefox:25483): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:29:59 INFO - PID 25434 | 12:30:09 INFO - PID 25434 | RSS: Main: 145215488 12:30:09 INFO - PID 25434 | 12:30:12 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45138/tests/kraken/driver.html?testName=audio-beat-detection) 12:30:13 INFO - PID 25434 | RSS: Main: 150933504 12:30:13 INFO - PID 25434 | 12:30:15 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45138/tests/kraken/driver.html?testName=audio-dft) 12:30:16 INFO - PID 25434 | RSS: Main: 152129536 12:30:16 INFO - PID 25434 | 12:30:19 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45138/tests/kraken/driver.html?testName=audio-fft) 12:30:19 INFO - PID 25434 | RSS: Main: 147771392 12:30:19 INFO - PID 25434 | 12:30:21 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45138/tests/kraken/driver.html?testName=audio-oscillator) 12:30:22 INFO - PID 25434 | RSS: Main: 149303296 12:30:22 INFO - PID 25434 | 12:30:24 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:30:25 INFO - PID 25434 | RSS: Main: 148951040 12:30:25 INFO - PID 25434 | 12:30:28 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45138/tests/kraken/driver.html?testName=imaging-darkroom) 12:30:28 INFO - PID 25434 | RSS: Main: 148992000 12:30:28 INFO - PID 25434 | 12:30:32 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45138/tests/kraken/driver.html?testName=imaging-desaturate) 12:30:32 INFO - PID 25434 | RSS: Main: 149905408 12:30:32 INFO - PID 25434 | 12:30:35 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45138/tests/kraken/driver.html?testName=json-parse-financial) 12:30:36 INFO - PID 25434 | RSS: Main: 151785472 12:30:36 INFO - PID 25434 | 12:30:37 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:30:38 INFO - PID 25434 | RSS: Main: 151764992 12:30:38 INFO - PID 25434 | 12:30:40 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:30:40 INFO - PID 25434 | RSS: Main: 151846912 12:30:40 INFO - PID 25434 | 12:30:42 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:30:43 INFO - PID 25434 | RSS: Main: 148606976 12:30:43 INFO - PID 25434 | 12:30:45 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:30:46 INFO - PID 25434 | RSS: Main: 148684800 12:30:46 INFO - PID 25434 | 12:30:49 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:30:49 INFO - PID 25434 | RSS: Main: 149602304 12:30:49 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | Cycle 1(1): loaded http://localhost:45138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45138/tests/kraken/driver.html?testName=ai-astar) 12:30:51 INFO - PID 25434 | RSS: Main: 150433792 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | __start_tp_report 12:30:51 INFO - PID 25434 | _x_x_mozilla_page_load 12:30:51 INFO - PID 25434 | _x_x_mozilla_page_load_details 12:30:51 INFO - PID 25434 | |i|pagename|runs| 12:30:51 INFO - PID 25434 | |0;ai-astar;103;104;104;104;106;105;106;105;105;105 12:30:51 INFO - PID 25434 | |1;audio-beat-detection;119;119;114;121;116;112;111;111;120;115 12:30:51 INFO - PID 25434 | |2;audio-dft;162;167;160;161;162;162;164;163;163;168 12:30:51 INFO - PID 25434 | |3;audio-fft;73;73;74;74;71;76;76;75;73;76 12:30:51 INFO - PID 25434 | |4;audio-oscillator;78;78;78;77;77;77;79;79;78;79 12:30:51 INFO - PID 25434 | |5;imaging-gaussian-blur;113;115;109;113;113;110;114;111;114;113 12:30:51 INFO - PID 25434 | |6;imaging-darkroom;148;150;148;150;149;149;158;151;150;151 12:30:51 INFO - PID 25434 | |7;imaging-desaturate;96;96;95;94;94;98;95;95;94;95 12:30:51 INFO - PID 25434 | |8;json-parse-financial;46;44;46;42;43;44;43;42;43;42 12:30:51 INFO - PID 25434 | |9;json-stringify-tinderbox;39;39;40;38;39;39;39;38;38;39 12:30:51 INFO - PID 25434 | |10;stanford-crypto-aes;70;72;73;69;73;73;68;70;68;69 12:30:51 INFO - PID 25434 | |11;stanford-crypto-ccm;106;102;107;104;114;101;108;107;112;106 12:30:51 INFO - PID 25434 | |12;stanford-crypto-pbkdf2;150;155;150;149;157;144;148;147;153;146 12:30:51 INFO - PID 25434 | |13;stanford-crypto-sha256-iterative;60;59;58;68;59;58;57;58;59;60 12:30:51 INFO - PID 25434 | __end_tp_report 12:30:51 INFO - PID 25434 | __start_cc_report 12:30:51 INFO - PID 25434 | _x_x_mozilla_cycle_collect,687 12:30:51 INFO - PID 25434 | __end_cc_report 12:30:51 INFO - PID 25434 | __startTimestamp1506972651602__endTimestamp 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | ------- Summary: start ------- 12:30:51 INFO - PID 25434 | Number of tests: 14 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#0] ai-astar Cycles:10 Average:104.70 Median:105.00 stddev:0.95 (0.9%) stddev-sans-first:0.78 12:30:51 INFO - PID 25434 | Values: 103.0 104.0 104.0 104.0 106.0 105.0 106.0 105.0 105.0 105.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:117.50 stddev:3.79 (3.2%) stddev-sans-first:3.84 12:30:51 INFO - PID 25434 | Values: 119.0 119.0 114.0 121.0 116.0 112.0 111.0 111.0 120.0 115.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.53 (1.6%) stddev-sans-first:2.65 12:30:51 INFO - PID 25434 | Values: 162.0 167.0 160.0 161.0 162.0 162.0 164.0 163.0 163.0 168.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.66 (2.2%) stddev-sans-first:1.72 12:30:51 INFO - PID 25434 | Values: 73.0 73.0 74.0 74.0 71.0 76.0 76.0 75.0 73.0 76.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 12:30:51 INFO - PID 25434 | Values: 78.0 78.0 78.0 77.0 77.0 77.0 79.0 79.0 78.0 79.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 12:30:51 INFO - PID 25434 | Values: 113.0 115.0 109.0 113.0 113.0 110.0 114.0 111.0 114.0 113.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:2.88 (1.9%) stddev-sans-first:2.92 12:30:51 INFO - PID 25434 | Values: 148.0 150.0 148.0 150.0 149.0 149.0 158.0 151.0 150.0 151.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 12:30:51 INFO - PID 25434 | Values: 96.0 96.0 95.0 94.0 94.0 98.0 95.0 95.0 94.0 95.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#8] json-parse-financial Cycles:10 Average:43.50 Median:43.50 stddev:1.51 (3.5%) stddev-sans-first:1.30 12:30:51 INFO - PID 25434 | Values: 46.0 44.0 46.0 42.0 43.0 44.0 43.0 42.0 43.0 42.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:0.63 (1.6%) stddev-sans-first:0.67 12:30:51 INFO - PID 25434 | Values: 39.0 39.0 40.0 38.0 39.0 39.0 39.0 38.0 38.0 39.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:71.00 stddev:2.07 (2.9%) stddev-sans-first:2.19 12:30:51 INFO - PID 25434 | Values: 70.0 72.0 73.0 69.0 73.0 73.0 68.0 70.0 68.0 69.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#11] stanford-crypto-ccm Cycles:10 Average:106.70 Median:107.00 stddev:4.03 (3.8%) stddev-sans-first:4.27 12:30:51 INFO - PID 25434 | Values: 106.0 102.0 107.0 104.0 114.0 101.0 108.0 107.0 112.0 106.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:150.00 stddev:4.07 (2.7%) stddev-sans-first:4.31 12:30:51 INFO - PID 25434 | Values: 150.0 155.0 150.0 149.0 157.0 144.0 148.0 147.0 153.0 146.0 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.00 stddev:3.10 (5.3%) stddev-sans-first:3.28 12:30:51 INFO - PID 25434 | Values: 60.0 59.0 58.0 68.0 59.0 58.0 57.0 58.0 59.0 60.0 12:30:51 INFO - PID 25434 | -------- Summary: end -------- 12:30:51 INFO - PID 25434 | 12:30:51 INFO - PID 25434 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:30:52 INFO - TEST-INFO | 25434: exit 0 12:30:52 INFO - TEST-OK | kraken | took 58948ms 12:30:52 INFO - SUITE-END | took 1166s 12:30:52 INFO - Completed test suite (00:19:26) 12:30:52 INFO - javascript benchmark 12:30:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9161.189148119836, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3832.06114501947, 3915.432262321963, 3939.0940083780747, 3946.605339466054, 3961.9405708914373, 6257.968710156443, 6317.684115794209, 6372.936270637292, 6454.0, 6487.221533415991, 6313.873722525546, 6365.204349456307, 6409.23089229292, 6509.73961041559, 6532.967335163317, 5685.630434021796, 5788.768449262025, 5792.826215213529, 5799.333076696192, 5814.825555233349, 126.88271382513574, 5532.944670553304, 5702.344230413514, 5708.714564271791, 5795.768169273224, 5717.313922329306, 5727.284089488814, 5729.742161602738, 5755.568332375067, 5800.897829412398, 5707.971460142673, 5725.627834190765, 5784.508316793078, 5799.159121927297, 5800.071988481823, 5712.742926568314, 5759.856003599902, 5779.1620215069, 5780.1907732917425, 5781.797637082682, 6304.747810087591, 6347.301796802348, 6371.203599550056, 6439.613623182624, 6439.839004024937, 6781.321867813179, 6805.523613347068, 6928.792136235921, 6958.721651133948, 7009.474289428314, 7036.859262814715, 7096.325849044332, 7103.467239957024, 7104.325089116525, 7110.7511237106455, 6413.6793160341795, 6469.644169570624, 6479.967600162016, 6485.189351331083, 6546.149000629887, 7063.223045464994, 7153.141623005168, 7161.104861892263, 7209.846424572043, 7219.278072192738, 6796.8300792479595, 6810.6254156020905, 6899.75850845218, 6901.344372284725, 6905.689243984033, 6889.931100688929, 6935.6878940447805, 6953.408960238336, 7025.613591252531, 7052.118485189351, 6950.582965022115, 6953.0, 6969.30306969299, 6971.3028697129885, 6999.265077166926, 6827.965860170667, 6974.686139123752, 6982.546134501241, 7009.754658586925, 7015.754448594377, 5028.321176641107, 5073.619478539051, 5081.5426611605135, 5099.413567439792, 5099.8725031873755, 4562.08758248345, 4566.200914839957, 4610.147122782296, 4610.654200934943, 4622.930656040162, 6358.777442789573, 6409.455196308366, 6416.903746443807, 6417.807465776034, 6420.1974753155855, 6872.62200578963, 6975.197852246955, 6976.651167441608, 7021.192562855234, 7029.824254393681, 6331.936680633226, 6427.325130861286, 6432.935670643327, 6467.353264673495, 6472.288048314682, 5578.191162281528, 5592.608517403824, 5654.46282603152, 5675.3757086720425, 5680.715964201773, 7142.607156606437, 7231.638418079075, 7235.565866048054, 7242.275772422821, 7246.891296630555, 6858.074159988338, 6908.481863860331, 6908.9309106909295, 6945.16658001033, 6980.860382792417, 7257.637118143966, 7296.963515182602, 7308.634568271672, 7310.0, 7312.268773122645, 6871.209810871814, 6894.655267236719, 6897.827554311182, 6999.230084690578, 7003.5797852129035, 6899.0, 6963.4777391694815, 6975.267596902252, 7017.403520700797, 7052.541584796972, 6709.329067093252, 6720.395164435029, 6725.19297684281, 6728.428083612947, 6752.729890804313, 6669.799906002828, 6719.092922455406, 6753.831154221184, 6781.38967492928, 6791.3548212919695, 6601.768938087336, 6610.570312929644, 6682.599044057372, 6684.197896252481, 6684.398404143651, 6704.66476676174, 6736.056952026818, 6738.494612903954, 6807.795766127024, 6847.863042739217, 6563.671816409065, 6571.901421478778, 6574.704138313883, 6577.473802095725, 6592.670366481752], "value": 6303.562873782426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [971.6210677835643, 997.1424574865616, 997.8104160209559, 998.8152191844514, 1009.2834087797663, 45261.0, 46367.30449043267, 46409.53590464099, 46454.767726161364, 46599.301010484785, 43237.35143972843, 43457.348139777925, 43632.12735745283, 43635.78182109093, 43681.781591092076, 7509.286617771303, 7579.431542634297, 7580.128285247212, 7580.507267027653, 7581.734639287626, 7563.470557061008, 7650.464467487278, 7668.693252269931, 7690.346320562759, 7713.267239612228, 7647.808804779897, 7688.961555192244, 8512.616932238065, 8677.479351238915, 8712.303015758724, 8561.44350617208, 8632.784180395478, 8634.481931084156, 8634.827303453958, 8644.049154592989, 8279.0, 8455.661773529051, 8496.447730897533, 8581.957090214572, 8604.82790344196, 42791.57208427907, 43237.0, 43265.0, 43274.350884736756, 43288.56711432877, 3735.3276410246144, 3736.23407201523, 3765.3975363941636, 3786.167043250508, 3787.0910981364273, 34735.131621709406, 34997.82501087478, 35043.0, 35090.12274693127, 35128.47307290393, 5410.3507579090365, 5446.754896029688, 5461.0716178249395, 5461.453854614547, 5477.643953143033, 226690.0, 227165.0, 227813.99999999834, 227841.0, 229107.0, 49289.75355123202, 50352.49647503478, 56292.718536407054, 56441.0, 57293.427065729644, 59197.0, 59250.0, 59257.70371148117, 59469.40530594725, 59502.0, 17500.124993750516, 17769.644607107784, 17792.37726679586, 17812.287508499776, 17830.10849457522, 13427.0, 13466.0, 13522.93238533801, 13669.726605467835, 13722.245276509688, 16146.111963841866, 16153.838461615469, 16177.19114044293, 16226.107564083854, 16278.104704241143, 5881.558883083786, 6053.7578496860515, 6165.537584681167, 6198.008318668992, 6316.557840951089, 1085.180688580117, 1088.5373716170595, 1091.5742860284495, 1103.7902798468265, 1114.3481063577735, 25222.369440764127, 25394.619080713805, 25475.61786573203, 25480.362990925376, 25687.229383118538, 1196.3719047499958, 1198.6044605280238, 1206.1014544164477, 1221.9511219551296, 1223.3883058470765, 13601.31993400326, 13764.31178441074, 13808.930955345159, 13845.930770346084, 13858.930705346409, 305172.0, 306831.0, 306837.0, 307095.0, 307214.0, 62884.68557657274, 63302.68348658319, 63491.0, 63516.0, 63613.0, 1499.3702644889172, 1506.683596444759, 1517.1276516003122, 1534.9309281082378, 1545.127003243164, 25583.488330233664, 25666.0, 25752.0, 25787.484250314512, 25892.0, 43912.34131487966, 44072.55927440813, 44088.77955610202, 44130.33804492871, 44152.0, 243394.0, 245610.0, 246541.0, 246753.0, 248945.0, 38336.80831595824, 38394.42408363821, 41106.0, 41558.37662435006, 41573.0, 50485.49514504808, 52021.47978520166, 52369.738151309, 52478.47521524736, 52757.208641869634, 37798.43302350522, 38270.0, 38307.0, 38439.423408648334, 38539.42190867083, 36588.26823463569, 36822.631773682995, 36864.63135368612, 37487.62512374841, 37551.0, 43377.132457351305, 45263.77368113138, 45335.54664453313, 45487.77256113698, 45500.0, 36453.81773091118, 36491.63508364988, 36625.63374366329, 36758.44862327121, 36945.0, 26863.731362686904, 27284.454310913272, 27293.0, 27658.308542286602, 27877.37540337016], "value": 19310.901274106363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.8599622086919, 617.5677026081742, 619.3682443907214, 621.468644309116, 630.5586089737185, 23509.29472115837, 23609.055637774512, 23997.520049599, 24136.517269654596, 24161.999999999978, 26137.301075430085, 26667.866660666718, 27030.5945410819, 27039.188824335302, 27052.864735676296, 6625.734970601182, 6767.255601883813, 6793.7961861143995, 6793.966030169842, 6795.0, 6586.275509693954, 6607.735690572371, 6676.599404035774, 6865.382115609594, 6898.448124150056, 6783.491238157158, 6818.897716534256, 6852.074969879052, 6861.691223894937, 6873.17521897373, 6672.699728512229, 6799.388055075042, 6860.348266914635, 6940.826479338007, 6954.200266969313, 6467.676616169173, 6468.964965605527, 6475.967620161869, 6493.51298652603, 6538.476921846241, 30535.69464305373, 30799.692003079905, 30964.8451757742, 31032.0, 31065.37869242625, 2153.6877152812913, 2174.239016344283, 2180.6401943679275, 2192.8136108430804, 2195.0451553574085, 20360.389188324374, 21949.231776887893, 22030.449238768997, 22081.668774968388, 22083.33749987503, 2588.8576128312934, 2606.126947472599, 2646.4442467081935, 2646.6559347284924, 2669.9599506007426, 145397.0, 149737.0, 152403.0, 157326.21336893243, 157431.2128439362, 15951.680966380607, 16407.507774766775, 16776.664466710597, 16864.39788220117, 16960.236789344508, 26850.194494165207, 26907.327316817235, 27040.32399190036, 27129.0, 27159.592606110924, 8725.389222754346, 8940.46357218556, 9045.050269721585, 9156.404833685789, 9183.954080229556, 7550.169481357047, 7629.809254768676, 7643.312101910855, 7693.730719424793, 7721.0, 10197.74505637365, 10205.642802502025, 10225.233107516966, 10302.0, 10341.896581034243, 2809.1572528241445, 2809.845458499802, 2861.0129505320633, 2890.147406515041, 2981.552767084911, 874.6807415293372, 895.3508706187962, 895.7088946092546, 907.8365894139118, 911.1799380557419, 19331.710024349646, 19825.801741982683, 19928.800711992986, 19948.70076948847, 20351.796482035286, 947.5593848860314, 948.7248697877676, 954.0983770336965, 956.9569369378395, 961.4615815143402, 10461.581536738597, 10636.095931845724, 10707.304025238334, 10781.514831832586, 10956.561737530568, 577239.0, 590256.0, 596475.0, 602387.0, 604485.0, 126648.36675816562, 126774.36612817062, 128447.0, 128911.0, 130102.34948825196, 1105.4307031878589, 1167.4804711903291, 1198.2451055834943, 1206.3304865799566, 1249.2504497301727, 22365.440863978532, 22612.434689132904, 22643.43391415228, 22698.205562805222, 22723.659145112506, 59872.0, 60911.39088609057, 61979.0, 63281.99999999816, 63383.0, 77510.61244693966, 78605.60697196478, 78732.0, 78966.0, 79404.0, 15907.920460397623, 15974.361025558848, 16038.67922641564, 16161.030338179748, 16331.510054698378, 21937.122515099218, 22193.66709499391, 22265.888670556542, 23006.07975681021, 24218.75781242165, 17916.193771280585, 18738.0, 18744.250229991194, 18926.810731892503, 18950.0524973748, 16174.757378639095, 16304.0, 16659.250333735254, 16674.66650667004, 16718.916405417895, 18687.532811679815, 20085.899570502053, 20213.494662632962, 20380.898095509427, 20435.693464598342, 16012.519624411287, 16142.273597687898, 16155.27301271422, 16178.110203938897, 16181.838181618034, 17731.911340443214, 18294.176762045474, 18321.0, 18465.261389544266, 18484.0], "value": 12544.826081627089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.766757318829, 1493.6041948883542, 1498.1161114942188, 1534.3785766764465, 1539.7690346448035, 16606.16969151542, 17131.143442827855, 17188.0, 17265.482035538924, 17336.82663173368, 17318.653626927455, 17879.73180402295, 17899.28402863887, 17916.55208619785, 17966.64066718665, 2805.8877644894233, 2845.502037143502, 2852.3724780548246, 2852.62915820943, 2853.743163115319, 2721.4965231432147, 2742.7394397532203, 2742.8765705543196, 2841.1618572521156, 2841.8152820066734, 2816.3663175785387, 2848.9287767805868, 2849.1167738001286, 2852.472292625871, 2853.7146285371505, 2713.2402927180324, 2737.890484380622, 2754.3664957059987, 2756.5589505679095, 2763.101991852646, 2712.1185614675114, 2758.2966343582457, 2759.696433392325, 2760.0477835146844, 2798.776097912162, 16806.24371903255, 16906.915465422717, 16979.49061528156, 16984.915075424542, 16986.0, 8251.917480825176, 8507.787305317355, 8527.275181609508, 8532.445391049561, 8543.231109200202, 5394.676319420847, 5526.226328314039, 5710.14347847822, 5716.1711551825165, 5716.485516303511, 1981.9108140133585, 2034.4201902457728, 2058.125296748876, 2082.72924519813, 2096.056774451503, 31168.37663246745, 31595.36809263802, 31598.36803263945, 31613.84193079043, 32435.51346729801, 7274.781756547312, 7283.162436319785, 7350.485466017328, 7429.665665045086, 7553.357964572963, 20749.27377541809, 20928.581428371654, 21050.894745526482, 21061.89469052645, 21073.157073717186, 8336.416450848383, 8554.18735220153, 8565.186307300797, 8568.914310856811, 8581.313494920516, 7525.698972041167, 7545.170031296553, 7598.278163574451, 7664.34853037498, 7688.077430708351, 5601.579881508822, 5802.593818432669, 5849.444302791228, 5912.586118971717, 5913.763449461973, 1579.7314456542415, 1610.5409958161868, 1729.1267909705518, 1757.1038770227276, 1768.6639538487645, 954.236610711428, 966.4539535162751, 976.2239019978991, 977.4330888084894, 982.5283863745442, 9184.586693598803, 9248.445093294424, 9249.768755781159, 9251.306152038489, 9338.206252468617, 1060.2154405739698, 1081.967540973772, 1090.2095980414294, 1095.7151140703315, 1099.9010089092021, 5567.944320556823, 5614.553145217264, 5628.915566266509, 5675.858103547362, 5853.560982926298, 24258.757412426003, 25331.87334063355, 26430.0, 26806.865965670437, 26853.194404167905, 25863.61204581933, 25998.6100208497, 26022.479550409265, 26262.0, 26322.47355052888, 12752.617421477371, 12872.0, 13000.609981700374, 13036.0, 13112.541061063008, 9077.954610226907, 9195.126462986005, 9216.861747073934, 9222.985471598253, 9431.151196392357, 21550.461238469165, 21740.45648858728, 21898.781012189673, 22115.33653990383, 22604.095836167027, 22710.545789084455, 22835.657465137705, 22855.20006799754, 23177.768222318235, 23324.76675233226, 13141.802872956721, 13272.80090798658, 13397.397117129947, 13414.061015728805, 13418.127821691558, 15955.0, 15965.920170399073, 16004.599885002503, 16156.757648635044, 16179.11014894145, 12846.421911014213, 13170.341482926007, 13340.733185336432, 13444.193348399127, 13446.663833404244, 12640.30478323701, 12759.0, 12780.744385112432, 12814.935925320313, 13253.469861205444, 10330.535125919201, 10385.84421233667, 10494.947525262325, 10507.78984420292, 10529.420881851265, 7723.459357844897, 7778.533288002738, 7813.882791758242, 7823.3350165234315, 8006.1993800619475, 8274.544900030556, 8308.33533317321, 8319.126491718282, 8377.162283771575, 8383.329333653415], "value": 7429.250948823742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.385860315122, 568.5530325322055, 583.4165834165834, 591.7455494137521, 604.8155312629649, 6378.330275321094, 6427.389398007193, 6432.742690292389, 6465.224173099235, 6480.675966201688, 6309.30597634261, 6310.0, 6317.431431171193, 6330.398612131851, 6340.714667839947, 5232.215167724834, 5234.162533994552, 5240.240165176047, 5241.606879484035, 5251.2385704072885, 4883.9755801220945, 5076.720780357079, 5193.143131383317, 5267.815626453075, 5271.103912334893, 5053.620978426614, 5097.286379906816, 5103.540681338679, 5130.0, 5152.407473140599, 5066.493350664941, 5099.719515426668, 5103.56619687327, 5111.974440127794, 5114.0, 4627.6529260305615, 4630.675852690313, 4634.814607415699, 4646.932115208733, 4668.486466488684, 6285.402886725754, 6300.369963003663, 6309.684515774239, 6327.27236367819, 6332.841678958017, 5968.7612495500125, 6075.48358389533, 6087.208662873798, 6104.908426373608, 6108.205933228652, 6668.899966500507, 6669.499787515956, 6731.326867313279, 6834.555753876032, 6835.897461538081, 5008.373953255843, 5165.276861239429, 5193.948060519384, 5199.168133098686, 5212.322398088262, 6794.422474089659, 6941.479389045841, 6977.93022069783, 7030.824229394255, 7081.645917704146, 5312.946870531323, 5330.333708286465, 5339.492748188916, 5350.866228344323, 5378.542823860016, 5365.168398898177, 5392.676439413648, 5421.403645598981, 5428.972855135778, 5482.396936337, 5951.226340575698, 5998.190244316961, 6031.698415079229, 6071.150038994544, 6072.483838873745, 6816.897746533806, 6848.417884479875, 6856.931430685729, 6879.759208427681, 6919.757808476679, 1845.4463660901677, 1872.2978882918906, 1875.4186202277338, 1885.5858106420185, 1891.6784146695095, 1305.2299143505377, 1320.9933950330378, 1330.940107695156, 1349.3740043247863, 1356.2269506381465, 6190.845228869224, 6209.285932117864, 6238.906416403757, 6239.221821780861, 6240.937590624036, 6684.328917770557, 6715.623297224058, 6752.696128674222, 6841.760538381232, 6858.554193977376, 6033.607815491979, 6122.816315510542, 6228.875422491525, 6294.622322660655, 6312.621242725451, 3574.392353299945, 3636.890893273206, 3645.3231513504084, 3658.926821463556, 3659.14010207601, 7047.674267491715, 7128.0, 7158.2125966143685, 7181.317774811385, 7203.0, 7012.684429200596, 7090.468214883801, 7093.333066729315, 7093.574385536885, 7102.792525270716, 7078.292170782881, 7117.928820711727, 7119.8932016020835, 7161.856762864713, 7182.892256616155, 6836.145481814773, 6856.5200435969, 6870.931290687229, 6890.896636550356, 6976.965115174392, 6802.14973128359, 6818.488613353919, 6823.317668233137, 6839.794806155824, 6851.657417129024, 7042.577445353295, 7047.541909775849, 7066.505344625827, 7096.964515177391, 7115.2884711530505, 5324.43263013774, 5342.98483288174, 5352.0366334060245, 5353.625246232882, 5379.757910893941, 6651.769422656824, 6663.900456424635, 6818.488613354118, 6842.349976752201, 6847.986885770245, 6215.0, 6545.541812073109, 6649.570342376219, 6670.83322916931, 6693.19681638187, 6631.867362652816, 6651.968944813561, 6662.666866656551, 6697.498801342527, 6713.61666608347, 6491.188601424822, 6502.219733631994, 6524.934750652623, 6576.408123268929, 6581.0, 6700.688262549413, 6742.415532349796, 6747.156605424322, 6772.458203343819, 6797.830054248683, 6496.545241833026, 6542.607443553402, 6558.737650493927, 6567.770128045687, 6607.702653380513], "value": 5291.030110408766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.8172547216024, 984.1880448629881, 994.5275993902897, 1001.7796084861328, 1004.2217281606754, 18628.441146765585, 19386.806131938694, 19390.4182874514, 19457.610847783035, 19836.9008154959, 19574.608507829835, 19825.504362390948, 19909.40271791845, 19909.701354479694, 19913.303034393764, 1027.0961553832635, 1049.522467277387, 1049.7900419916048, 1050.8581341518911, 1051.7528380830538, 1062.1874266186373, 1063.2716589136428, 1066.0831684751108, 1066.7813098314828, 1067.0, 1056.1392465140887, 1091.045335331585, 1091.8307662312354, 1125.071815752008, 1128.9943550282278, 1070.1064611049783, 1082.870055593326, 1083.6803143072812, 1084.4957094950885, 1085.0505807418508, 783.3419927261128, 783.9490433121829, 790.4111436979487, 792.1088775127981, 797.5772840394542, 20134.79865201344, 20188.596228075505, 20305.390838274874, 20307.89846050775, 20387.08258128373, 22778.974946127462, 23148.42128946773, 23160.76839231603, 23654.172103976278, 23670.289891303288, 18203.18085686134, 18290.08549572516, 18454.44636660889, 18642.0, 18664.533386665444, 3975.1254723960683, 3977.840886364542, 4008.518977722663, 4018.7588744675413, 4023.2154729827694, 142289.2885535576, 172402.99999999875, 175082.0, 177161.0, 179399.0, 19067.237310507702, 19195.80804191968, 19295.324663636704, 19306.42080737552, 19316.420507384802, 33242.3351532968, 34977.65022349744, 35109.64890351115, 35194.47208291878, 35315.293694126485, 9594.136527712539, 9705.223582113415, 9796.804063918682, 9892.208623310118, 9931.702048938543, 4502.707324023928, 4532.886677833015, 4543.818247270138, 4582.266837306015, 4590.770461476913, 5934.991051521251, 6054.091886217103, 6134.38656134383, 6153.4154255345675, 6199.752009919643, 1168.9824652630218, 1178.4637989714658, 1193.7493126443544, 1198.0415667465993, 1205.3551350027692, 676.3473248315399, 707.1973310292752, 709.1419382547073, 711.2247650061355, 715.860407220587, 12049.698757531132, 12298.692532686755, 12544.623661290176, 12626.684332891567, 12712.491500339884, 655.0828839624563, 663.3830537600078, 667.4460198035619, 671.4628297362091, 679.5616827146463, 5714.942850571524, 5783.971080144656, 5849.853753656193, 5875.324337701134, 5939.4951429129005, 160145.0, 162736.0, 162769.0, 163983.0, 166089.0, 141369.0, 141963.29018355047, 142363.0, 144606.2769686145, 145843.0, 121106.3944680271, 121444.0, 123336.38331808284, 125149.0, 127476.36261818632, 10810.29733067348, 10829.429732688559, 10902.50938707776, 10967.0, 11145.832812507657, 58040.4195958035, 58823.41176588179, 59455.0, 59512.10731838939, 59749.70125149346, 70548.29451705418, 72289.6385518069, 72457.0, 73061.6346918262, 76250.0, 17467.650646987244, 17565.12174391301, 17571.472855814347, 17624.29502819873, 17797.288108476034, 17697.292108315523, 18110.456686299432, 18327.63344733071, 18333.449996500127, 18460.723089153405, 16399.42602008924, 16426.917865410596, 16431.753523697393, 16446.75329870029, 16455.917720411322, 18417.723734143732, 18480.0, 18549.629007419506, 18580.070996449853, 18619.906900465412, 16639.66720665556, 16909.577260568585, 16939.745903811698, 16952.152392380085, 17013.319467221172, 11386.089112870784, 11705.180637355303, 11898.0, 12052.0, 12124.0, 12287.201331913397, 12424.813627795409, 12530.37348132608, 12623.789530372793, 12758.48966041348], "value": 9847.961863937702, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 104.0, 104.0, 106.0, 105.0, 106.0, 105.0, 105.0, 105.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 114.0, 121.0, 116.0, 112.0, 111.0, 111.0, 120.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 160.0, 161.0, 162.0, 162.0, 164.0, 163.0, 163.0, 168.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 71.0, 76.0, 76.0, 75.0, 73.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 77.0, 77.0, 79.0, 79.0, 78.0, 79.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 109.0, 113.0, 113.0, 110.0, 114.0, 111.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 150.0, 149.0, 149.0, 158.0, 151.0, 150.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 94.0, 98.0, 95.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 46.0, 42.0, 43.0, 44.0, 43.0, 42.0, 43.0, 42.0], "value": 43.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 40.0, 38.0, 39.0, 39.0, 39.0, 38.0, 38.0, 39.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 73.0, 69.0, 73.0, 73.0, 68.0, 70.0, 68.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 107.0, 104.0, 114.0, 101.0, 108.0, 107.0, 112.0, 106.0], "value": 106.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 150.0, 149.0, 157.0, 144.0, 148.0, 147.0, 153.0, 146.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 68.0, 59.0, 58.0, 57.0, 58.0, 59.0, 60.0], "value": 59.6, "unit": "score"}]}]} 12:30:52 INFO - Return code: 0 12:30:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:30:52 INFO - # TBPL SUCCESS # 12:30:52 INFO - Running post-action listener: _package_coverage_data 12:30:52 INFO - Running post-action listener: _resource_record_post_action 12:30:52 INFO - [mozharness: 2017-10-02 19:30:52.396736Z] Finished run-tests step (success) 12:30:52 INFO - Running post-run listener: _resource_record_post_run 12:30:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321634304; Read time: 12; Write time: 212240 12:30:52 INFO - TinderboxPrint: CPU usage
13.1% 12:30:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:30:52 INFO - TinderboxPrint: I/O write bytes / time
321,634,304 / 212,240 12:30:52 INFO - TinderboxPrint: CPU idle
8,213.1 (86.9%) 12:30:52 INFO - TinderboxPrint: CPU user
1,187.0 (12.6%) 12:30:52 INFO - TinderboxPrint: Swap in / out
0 / 0 12:30:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12513280; Read time: 0; Write time: 2760 12:30:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:30:52 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308105216; Read time: 12; Write time: 209452 12:30:53 INFO - Running post-run listener: _upload_blobber_files 12:30:53 INFO - Blob upload gear active. 12:30:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:30:53 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 12:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:30:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:54 INFO - (blobuploader) - INFO - Done attempting. 12:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:01 INFO - (blobuploader) - INFO - Done attempting. 12:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:02 INFO - (blobuploader) - INFO - Done attempting. 12:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:03 INFO - (blobuploader) - INFO - Done attempting. 12:31:03 INFO - (blobuploader) - INFO - Iteration through files over. 12:31:03 INFO - Return code: 0 12:31:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:31:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:31:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c3730dd8a0f676bbd64a61e8a3bbb8accc8ead31c3355b48d465dff48ab464cd1dbdb11dd0be17fd1be1061a6716116f11ed0599f32fece52afb290ca337da1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd2484cd2f971b7288937d2b2d3bd2fef4f402c6079f89b36fedfbf1b1d5ebab7f26d7462539411a6c65250b5df4f78127b76ed4d32cc6907d0e59b4ffe7e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2b656c0e11d97678d406c505e0113650765864a8bea74aaab4fa2a6a13e6ec274faa2a8677da461d087084555e3fbc6fb6b1acfd004845628fb7df97d1641e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/886f64d62fd7d85ce376b6359c9fbeb6932df01c5d2efaba59b5341e78b89b02a6d49a8a9245b28daacfbd6d8de33190c178236b697500e9e7184655f00e8af8"} 12:31:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:31:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:31:03 INFO - Contents: 12:31:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c3730dd8a0f676bbd64a61e8a3bbb8accc8ead31c3355b48d465dff48ab464cd1dbdb11dd0be17fd1be1061a6716116f11ed0599f32fece52afb290ca337da1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd2484cd2f971b7288937d2b2d3bd2fef4f402c6079f89b36fedfbf1b1d5ebab7f26d7462539411a6c65250b5df4f78127b76ed4d32cc6907d0e59b4ffe7e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2b656c0e11d97678d406c505e0113650765864a8bea74aaab4fa2a6a13e6ec274faa2a8677da461d087084555e3fbc6fb6b1acfd004845628fb7df97d1641e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/886f64d62fd7d85ce376b6359c9fbeb6932df01c5d2efaba59b5341e78b89b02a6d49a8a9245b28daacfbd6d8de33190c178236b697500e9e7184655f00e8af8"} 12:31:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:31:03 INFO - Copying logs to upload dir... 12:31:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:31:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.247491 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-10-02 12:31:03.958386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 12:31:03.965854) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c3730dd8a0f676bbd64a61e8a3bbb8accc8ead31c3355b48d465dff48ab464cd1dbdb11dd0be17fd1be1061a6716116f11ed0599f32fece52afb290ca337da1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd2484cd2f971b7288937d2b2d3bd2fef4f402c6079f89b36fedfbf1b1d5ebab7f26d7462539411a6c65250b5df4f78127b76ed4d32cc6907d0e59b4ffe7e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2b656c0e11d97678d406c505e0113650765864a8bea74aaab4fa2a6a13e6ec274faa2a8677da461d087084555e3fbc6fb6b1acfd004845628fb7df97d1641e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/886f64d62fd7d85ce376b6359c9fbeb6932df01c5d2efaba59b5341e78b89b02a6d49a8a9245b28daacfbd6d8de33190c178236b697500e9e7184655f00e8af8"} build_url:https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/HoZpg5sHQb2RIyQu0rOepw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c3730dd8a0f676bbd64a61e8a3bbb8accc8ead31c3355b48d465dff48ab464cd1dbdb11dd0be17fd1be1061a6716116f11ed0599f32fece52afb290ca337da1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6bd2484cd2f971b7288937d2b2d3bd2fef4f402c6079f89b36fedfbf1b1d5ebab7f26d7462539411a6c65250b5df4f78127b76ed4d32cc6907d0e59b4ffe7e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b2b656c0e11d97678d406c505e0113650765864a8bea74aaab4fa2a6a13e6ec274faa2a8677da461d087084555e3fbc6fb6b1acfd004845628fb7df97d1641e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/886f64d62fd7d85ce376b6359c9fbeb6932df01c5d2efaba59b5341e78b89b02a6d49a8a9245b28daacfbd6d8de33190c178236b697500e9e7184655f00e8af8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 12:31:03.997509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:31:03.997827) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506970593.597765-1163713599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 12:31:04.050891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 12:31:04.051219) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 12:31:04.051510) ========= ========= Total master_lag: 0.71 =========