builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1504980911.68 results: success (0) revision: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.681000) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.681421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.681693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.699045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.699346) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 11:15:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.1M=0s 2017-09-09 11:15:11 (86.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.835309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.835707) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014618 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.884981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:11.885323) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21699515e84bc218b3a963f4af426a9ed7c7f8a4 --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 21699515e84bc218b3a963f4af426a9ed7c7f8a4 --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=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 11:15:11,935 truncating revision to first 12 chars 2017-09-09 11:15:11,935 Setting DEBUG logging. 2017-09-09 11:15:11,935 attempt 1/10 2017-09-09 11:15:11,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21699515e84b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 11:15:12,542 unpacking tar archive at: mozilla-central-21699515e84b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:12.863524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:12.863838) ========= script_repo_revision: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:12.864268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:12.864526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 11:15:12.878524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-09 11:15:12.878866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:13 INFO - MultiFileLogger online at 20170909 11:15:13 in /builds/slave/test 11:15:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:15:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:13 INFO - {'append_to_log': False, 11:15:13 INFO - 'base_work_dir': '/builds/slave/test', 11:15:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:15:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:13 INFO - 'branch': 'Firefox-Non-PGO', 11:15:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:13 INFO - 'code_coverage': False, 11:15:13 INFO - 'config_files': ('talos/linux_config.py',), 11:15:13 INFO - 'default_actions': ('clobber', 11:15:13 INFO - 'read-buildbot-config', 11:15:13 INFO - 'download-and-extract', 11:15:13 INFO - 'populate-webroot', 11:15:13 INFO - 'create-virtualenv', 11:15:13 INFO - 'install', 11:15:13 INFO - 'setup-mitmproxy', 11:15:13 INFO - 'run-tests'), 11:15:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:13 INFO - 'disable_ccov_upload': False, 11:15:13 INFO - 'disable_stylo': False, 11:15:13 INFO - 'download_minidump_stackwalk': True, 11:15:13 INFO - 'download_symbols': 'ondemand', 11:15:13 INFO - 'enable_stylo': False, 11:15:13 INFO - 'enable_webrender': False, 11:15:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:15:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:13 INFO - 'gecko_profile': False, 11:15:13 INFO - 'gecko_profile_interval': 0, 11:15:13 INFO - 'installer_path': 'installer.exe', 11:15:13 INFO - 'log_level': 'info', 11:15:13 INFO - 'log_name': 'talos', 11:15:13 INFO - 'log_to_console': True, 11:15:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:13 INFO - 'opt_config_files': (), 11:15:13 INFO - 'pip_index': False, 11:15:13 INFO - 'suite': 'dromaeojs-e10s', 11:15:13 INFO - 'system_bits': '32', 11:15:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:13 INFO - 'title': 'talos-linux64-ix-064', 11:15:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:13 INFO - 'use_talos_json': True, 11:15:13 INFO - 'verify': 'False', 11:15:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:13 INFO - 'work_dir': 'build'} 11:15:13 INFO - [mozharness: 2017-09-09 18:15:13.070408Z] Running clobber step. 11:15:13 INFO - Running pre-action listener: _resource_record_pre_action 11:15:13 INFO - Running main action method: clobber 11:15:13 INFO - rmtree: /builds/slave/test/build 11:15:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:14 INFO - Running post-action listener: _resource_record_post_action 11:15:14 INFO - [mozharness: 2017-09-09 18:15:14.127918Z] Finished clobber step (success) 11:15:14 INFO - [mozharness: 2017-09-09 18:15:14.128015Z] Running read-buildbot-config step. 11:15:14 INFO - Running pre-action listener: _resource_record_pre_action 11:15:14 INFO - Running main action method: read_buildbot_config 11:15:14 INFO - Using buildbot properties: 11:15:14 INFO - { 11:15:14 INFO - "project": "", 11:15:14 INFO - "product": "firefox", 11:15:14 INFO - "who": "ffxbld@noreply.mozilla.org", 11:15:14 INFO - "installer_path": "public/build/target.tar.bz2", 11:15:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:15:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:15:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:15:14 INFO - "stage_platform": "linux64", 11:15:14 INFO - "basedir": "/builds/slave/test", 11:15:14 INFO - "buildnumber": 1129, 11:15:14 INFO - "platform": "ubuntu64_hw", 11:15:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:15:14 INFO - "slavebuilddir": "test", 11:15:14 INFO - "taskId": "XtEakubYR7Clj3ZU5rR2kQ", 11:15:14 INFO - "branch": "mozilla-central", 11:15:14 INFO - "script_repo_revision": "production", 11:15:14 INFO - "revision": "21699515e84bc218b3a963f4af426a9ed7c7f8a4", 11:15:14 INFO - "slavename": "talos-linux64-ix-064", 11:15:14 INFO - "repo_path": "mozilla-central" 11:15:14 INFO - } 11:15:14 INFO - Finding installer, test and symbols from parent task. 11:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtEakubYR7Clj3ZU5rR2kQ'}, attempt #1 11:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtEakubYR7Clj3ZU5rR2kQ'}, attempt #1 11:15:15 INFO - Task dependencies: TzHGlhiiRQCEEVlLYRX_gg 11:15:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg'}, attempt #1 11:15:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:15:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json 11:15:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip 11:15:15 INFO - Running post-action listener: _resource_record_post_action 11:15:15 INFO - [mozharness: 2017-09-09 18:15:15.517690Z] Finished read-buildbot-config step (success) 11:15:15 INFO - [mozharness: 2017-09-09 18:15:15.517906Z] Running download-and-extract step. 11:15:15 INFO - Running pre-action listener: _resource_record_pre_action 11:15:15 INFO - Running main action method: download_and_extract 11:15:15 INFO - mkdir: /builds/slave/test/build/tests 11:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:15 INFO - trying https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json 11:15:15 INFO - Downloading https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:15:16 INFO - Downloaded 989 bytes. 11:15:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:15:16 INFO - Using the following test package requirements: 11:15:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:15:16 INFO - u'common': [u'target.common.tests.zip'], 11:15:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:15:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:15:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:15:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:15:16 INFO - u'mozbase': [u'target.common.tests.zip'], 11:15:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:15:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:15:16 INFO - u'web-platform': [u'target.common.tests.zip', 11:15:16 INFO - u'target.web-platform.tests.tar.gz'], 11:15:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:15:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:15:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip 11:15:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip into memory 11:15:17 INFO - Content-Length response header: 55024757 11:15:17 INFO - Bytes received: 55024757 11:15:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip 11:15:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:15:28 INFO - Fetch https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip into memory 11:15:28 INFO - Content-Length response header: 14497963 11:15:28 INFO - Bytes received: 14497963 11:15: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')]} 11:15:29 INFO - trying https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:15:30 INFO - Downloaded 62922539 bytes. 11:15:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:15:30 INFO - mkdir: /builds/slave/test/properties 11:15:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:30 INFO - Contents: 11:15:30 INFO - build_url:https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:15:30 INFO - Running post-action listener: _resource_record_post_action 11:15:30 INFO - Running post-action listener: find_tests_for_verification 11:15:30 INFO - Running post-action listener: set_extra_try_arguments 11:15:30 INFO - [mozharness: 2017-09-09 18:15:30.204996Z] Finished download-and-extract step (success) 11:15:30 INFO - [mozharness: 2017-09-09 18:15:30.205110Z] Running populate-webroot step. 11:15:30 INFO - Running pre-action listener: _resource_record_pre_action 11:15:30 INFO - Running main action method: populate_webroot 11:15:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:30 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['tresize', 11:15:30 INFO - 'tcanvasmark']}, 11:15:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:30 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['dromaeo_css', 11:15:30 INFO - 'kraken']}, 11:15:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:30 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'tests': ['damp', 'tps']}, 11:15:30 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['damp', 'tps']}, 11:15:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:30 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['dromaeo_dom']}, 11:15:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:15:30 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['basic_compositor_video', 11:15:30 INFO - 'glvideo']}, 11:15:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:30 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['ts_paint_webext', 11:15:30 INFO - 'tp5o_webext']}, 11:15:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_many_windows', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['a11yr', 11:15:30 INFO - 'ts_paint', 11:15:30 INFO - 'tpaint', 11:15:30 INFO - 'sessionrestore', 11:15:30 INFO - 'sessionrestore_many_windows', 11:15:30 INFO - 'sessionrestore_no_auto_restore', 11:15:30 INFO - 'tabpaint']}, 11:15:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:15:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:15:30 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['bloom_basic_singleton']}, 11:15:30 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['bloom_basic']}, 11:15:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:30 INFO - 'tsvgr_opacity', 11:15:30 INFO - 'tart', 11:15:30 INFO - 'tscrollx', 11:15:30 INFO - 'tsvg_static']}, 11:15:30 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['tsvgx', 11:15:30 INFO - 'tsvgr_opacity', 11:15:30 INFO - 'tart', 11:15:30 INFO - 'tscrollx', 11:15:30 INFO - 'tsvg_static']}, 11:15:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:15:30 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo'], 11:15:30 INFO - 'tests': ['tp5o']}, 11:15:30 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:30 INFO - 'talos_options': ['--mitmproxy', 11:15:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:30 INFO - '--firstNonBlankPaint'], 11:15:30 INFO - 'tests': ['tp6_google', 11:15:30 INFO - 'tp6_youtube', 11:15:30 INFO - 'tp6_amazon', 11:15:30 INFO - 'tp6_facebook']}, 11:15:30 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo', 11:15:30 INFO - '--mitmproxy', 11:15:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:30 INFO - '--firstNonBlankPaint'], 11:15:30 INFO - 'tests': ['tp6_google', 11:15:30 INFO - 'tp6_youtube', 11:15:30 INFO - 'tp6_amazon', 11:15:30 INFO - 'tp6_facebook']}, 11:15:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:30 INFO - 'talos_options': ['--stylo-threads=1', 11:15:30 INFO - '--mitmproxy', 11:15:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:30 INFO - '--firstNonBlankPaint'], 11:15:30 INFO - 'tests': ['tp6_google', 11:15:30 INFO - 'tp6_youtube', 11:15:30 INFO - 'tp6_amazon', 11:15:30 INFO - 'tp6_facebook']}, 11:15:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--xperf_path', 11:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:30 INFO - 'tests': ['tp5n']}, 11:15:30 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:30 INFO - 'talos_options': ['--disable-stylo', 11:15:30 INFO - '--xperf_path', 11:15:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:30 INFO - 'tests': ['tp5n']}}} 11:15:30 INFO - Running post-action listener: _resource_record_post_action 11:15:30 INFO - [mozharness: 2017-09-09 18:15:30.222311Z] Finished populate-webroot step (success) 11:15:30 INFO - [mozharness: 2017-09-09 18:15:30.222418Z] Running create-virtualenv step. 11:15:30 INFO - Running pre-action listener: _resource_record_pre_action 11:15:30 INFO - Running main action method: create_virtualenv 11:15:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:30 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:30 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:15:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:15:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:31 INFO - Installing pip...............done. 11:15:31 INFO - Return code: 0 11:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:15:31 INFO - Reading from file tmpfile_stdout 11:15:31 INFO - Output received: 11:15:31 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:31 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:31 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 11:15:31 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 11:15:31 INFO - Using env: {'DISPLAY': ':0', 11:15:31 INFO - 'HOME': '/home/cltbld', 11:15:31 INFO - 'LANG': 'en_US.UTF-8', 11:15:31 INFO - 'LANGUAGE': 'en_US:en', 11:15:31 INFO - 'LOGNAME': 'cltbld', 11:15:31 INFO - 'MAIL': '/var/mail/cltbld', 11:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:31 INFO - 'MOZ_NO_REMOTE': '1', 11:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:31 INFO - 'NO_EM_RESTART': '1', 11:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:31 INFO - 'PWD': '/builds/slave/test', 11:15:31 INFO - 'SHELL': '/bin/bash', 11:15:31 INFO - 'SHLVL': '1', 11:15:31 INFO - 'TERM': 'linux', 11:15:31 INFO - 'TMOUT': '86400', 11:15:31 INFO - 'USER': 'cltbld', 11:15:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:31 INFO - '_': '/tools/buildbot/bin/python'} 11:15:32 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:15:32 INFO - Downloading/unpacking pip>=1.5 11:15:32 INFO - Running setup.py egg_info for package pip 11:15:32 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:32 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:32 INFO - Installing collected packages: pip 11:15:32 INFO - Found existing installation: pip 1.1 11:15:32 INFO - Uninstalling pip: 11:15:32 INFO - Successfully uninstalled pip 11:15:32 INFO - Running setup.py install for pip 11:15:32 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:32 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:32 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:32 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:32 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:15:32 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:15:32 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:15:32 INFO - Successfully installed pip 11:15:32 INFO - Cleaning up... 11:15:32 INFO - Return code: 0 11:15:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:32 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')]} 11:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:32 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')]} 11:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:32 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:32 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 11:15:32 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 11:15:32 INFO - Using env: {'DISPLAY': ':0', 11:15:32 INFO - 'HOME': '/home/cltbld', 11:15:32 INFO - 'LANG': 'en_US.UTF-8', 11:15:32 INFO - 'LANGUAGE': 'en_US:en', 11:15:32 INFO - 'LOGNAME': 'cltbld', 11:15:32 INFO - 'MAIL': '/var/mail/cltbld', 11:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:32 INFO - 'MOZ_NO_REMOTE': '1', 11:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:32 INFO - 'NO_EM_RESTART': '1', 11:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:32 INFO - 'PWD': '/builds/slave/test', 11:15:32 INFO - 'SHELL': '/bin/bash', 11:15:32 INFO - 'SHLVL': '1', 11:15:32 INFO - 'TERM': 'linux', 11:15:32 INFO - 'TMOUT': '86400', 11:15:32 INFO - 'USER': 'cltbld', 11:15:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:32 INFO - '_': '/tools/buildbot/bin/python'} 11:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:32 INFO - Downloading/unpacking psutil>=3.1.1 11:15:32 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 11:15:32 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 11:15:32 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 11:15:32 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 11:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:33 INFO - Installing collected packages: psutil 11:15:33 INFO - Running setup.py install for psutil 11:15:33 INFO - building 'psutil._psutil_linux' extension 11:15:33 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 11:15:34 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 11:15:34 INFO - building 'psutil._psutil_posix' extension 11:15:34 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 11:15:34 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 11:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:34 INFO - Successfully installed psutil 11:15:34 INFO - Cleaning up... 11:15:34 INFO - Return code: 0 11:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15:34 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')]} 11:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:34 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')]} 11:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:34 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:34 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 11:15:34 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 11:15:34 INFO - Using env: {'DISPLAY': ':0', 11:15:34 INFO - 'HOME': '/home/cltbld', 11:15:34 INFO - 'LANG': 'en_US.UTF-8', 11:15:34 INFO - 'LANGUAGE': 'en_US:en', 11:15:34 INFO - 'LOGNAME': 'cltbld', 11:15:34 INFO - 'MAIL': '/var/mail/cltbld', 11:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:34 INFO - 'MOZ_NO_REMOTE': '1', 11:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:34 INFO - 'NO_EM_RESTART': '1', 11:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:34 INFO - 'PWD': '/builds/slave/test', 11:15:34 INFO - 'SHELL': '/bin/bash', 11:15:34 INFO - 'SHLVL': '1', 11:15:34 INFO - 'TERM': 'linux', 11:15:34 INFO - 'TMOUT': '86400', 11:15:34 INFO - 'USER': 'cltbld', 11:15:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:34 INFO - '_': '/tools/buildbot/bin/python'} 11:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:34 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 11:15:34 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 11:15:34 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 11:15:34 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 11:15:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:35 INFO - Installing collected packages: mozsystemmonitor 11:15:35 INFO - Running setup.py install for mozsystemmonitor 11:15:35 INFO - Successfully installed mozsystemmonitor 11:15:35 INFO - Cleaning up... 11:15:36 INFO - Return code: 0 11:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:36 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:36 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 11:15:36 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 11:15:36 INFO - Using env: {'DISPLAY': ':0', 11:15:36 INFO - 'HOME': '/home/cltbld', 11:15:36 INFO - 'LANG': 'en_US.UTF-8', 11:15:36 INFO - 'LANGUAGE': 'en_US:en', 11:15:36 INFO - 'LOGNAME': 'cltbld', 11:15:36 INFO - 'MAIL': '/var/mail/cltbld', 11:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:36 INFO - 'MOZ_NO_REMOTE': '1', 11:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:36 INFO - 'NO_EM_RESTART': '1', 11:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:36 INFO - 'PWD': '/builds/slave/test', 11:15:36 INFO - 'SHELL': '/bin/bash', 11:15:36 INFO - 'SHLVL': '1', 11:15:36 INFO - 'TERM': 'linux', 11:15:36 INFO - 'TMOUT': '86400', 11:15:36 INFO - 'USER': 'cltbld', 11:15:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:36 INFO - '_': '/tools/buildbot/bin/python'} 11:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:37 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 11:15:37 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 11:15:37 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 11:15:37 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 11:15:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:38 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 11:15:38 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 11:15:38 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 11:15:38 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 11:15:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:38 INFO - warning: no files found matching '*.txt' 11:15:38 INFO - no previously-included directories found matching 'build' 11:15:38 INFO - no previously-included directories found matching 'dist' 11:15:38 INFO - no previously-included directories found matching '.git*' 11:15:38 INFO - Installing collected packages: jsonschema, functools32 11:15:38 INFO - Running setup.py install for functools32 11:15:39 INFO - warning: no files found matching '*.txt' 11:15:39 INFO - no previously-included directories found matching 'build' 11:15:39 INFO - no previously-included directories found matching 'dist' 11:15:39 INFO - no previously-included directories found matching '.git*' 11:15:39 INFO - Successfully installed jsonschema functools32 11:15:39 INFO - Cleaning up... 11:15:39 INFO - Return code: 0 11:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:39 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')]} 11:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:39 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')]} 11:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:39 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:39 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 11:15:39 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 11:15:39 INFO - Using env: {'DISPLAY': ':0', 11:15:39 INFO - 'HOME': '/home/cltbld', 11:15:39 INFO - 'LANG': 'en_US.UTF-8', 11:15:39 INFO - 'LANGUAGE': 'en_US:en', 11:15:39 INFO - 'LOGNAME': 'cltbld', 11:15:39 INFO - 'MAIL': '/var/mail/cltbld', 11:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:39 INFO - 'MOZ_NO_REMOTE': '1', 11:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:39 INFO - 'NO_EM_RESTART': '1', 11:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:39 INFO - 'PWD': '/builds/slave/test', 11:15:39 INFO - 'SHELL': '/bin/bash', 11:15:39 INFO - 'SHLVL': '1', 11:15:39 INFO - 'TERM': 'linux', 11:15:39 INFO - 'TMOUT': '86400', 11:15:39 INFO - 'USER': 'cltbld', 11:15:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:39 INFO - '_': '/tools/buildbot/bin/python'} 11:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:39 INFO - Cleaning up... 11:15:39 INFO - Return code: 0 11:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:39 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')]} 11:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:39 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')]} 11:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:39 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:39 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 11:15:39 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 11:15:39 INFO - Using env: {'DISPLAY': ':0', 11:15:39 INFO - 'HOME': '/home/cltbld', 11:15:39 INFO - 'LANG': 'en_US.UTF-8', 11:15:39 INFO - 'LANGUAGE': 'en_US:en', 11:15:39 INFO - 'LOGNAME': 'cltbld', 11:15:39 INFO - 'MAIL': '/var/mail/cltbld', 11:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:39 INFO - 'MOZ_NO_REMOTE': '1', 11:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:39 INFO - 'NO_EM_RESTART': '1', 11:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:39 INFO - 'PWD': '/builds/slave/test', 11:15:39 INFO - 'SHELL': '/bin/bash', 11:15:39 INFO - 'SHLVL': '1', 11:15:39 INFO - 'TERM': 'linux', 11:15:39 INFO - 'TMOUT': '86400', 11:15:39 INFO - 'USER': 'cltbld', 11:15:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:39 INFO - '_': '/tools/buildbot/bin/python'} 11:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:39 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 11:15:39 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 11:15:39 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 11:15:39 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 11:15:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15:40 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 11:15:40 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 11:15:40 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 11:15:40 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 11:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15:41 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 11:15:41 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 11:15:41 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 11:15:41 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 11:15:41 INFO - Downloading docopt-0.6.1.tar.gz 11:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:41 INFO - Running setup.py install for blobuploader 11:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:41 INFO - Running setup.py install for requests 11:15:41 INFO - Running setup.py install for docopt 11:15:41 INFO - Successfully installed blobuploader requests docopt 11:15:41 INFO - Cleaning up... 11:15:42 INFO - Return code: 0 11:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:42 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:42 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 11:15:42 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 11:15:42 INFO - Using env: {'DISPLAY': ':0', 11:15:42 INFO - 'HOME': '/home/cltbld', 11:15:42 INFO - 'LANG': 'en_US.UTF-8', 11:15:42 INFO - 'LANGUAGE': 'en_US:en', 11:15:42 INFO - 'LOGNAME': 'cltbld', 11:15:42 INFO - 'MAIL': '/var/mail/cltbld', 11:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:42 INFO - 'MOZ_NO_REMOTE': '1', 11:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:42 INFO - 'NO_EM_RESTART': '1', 11:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:42 INFO - 'PWD': '/builds/slave/test', 11:15:42 INFO - 'SHELL': '/bin/bash', 11:15:42 INFO - 'SHLVL': '1', 11:15:42 INFO - 'TERM': 'linux', 11:15:42 INFO - 'TMOUT': '86400', 11:15:42 INFO - 'USER': 'cltbld', 11:15:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:42 INFO - '_': '/tools/buildbot/bin/python'} 11:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:42 INFO - Running setup.py (path:/tmp/pip-svCn6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:42 INFO - Running setup.py (path:/tmp/pip-5t0lNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:42 INFO - Running setup.py (path:/tmp/pip-b_OVst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:42 INFO - Running setup.py (path:/tmp/pip-fo6dqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:42 INFO - Running setup.py (path:/tmp/pip-UBAdsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:42 INFO - Running setup.py (path:/tmp/pip-yAbByE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:42 INFO - Running setup.py (path:/tmp/pip-jhScO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:42 INFO - Running setup.py (path:/tmp/pip-EUp1eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:42 INFO - Running setup.py (path:/tmp/pip-GHdOdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:42 INFO - Running setup.py (path:/tmp/pip-4NzIiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:42 INFO - Running setup.py (path:/tmp/pip-Q0XsZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:43 INFO - Running setup.py (path:/tmp/pip-_Cg8ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:43 INFO - Running setup.py (path:/tmp/pip-XJRFJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:43 INFO - Running setup.py (path:/tmp/pip-BCOErj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:43 INFO - Running setup.py (path:/tmp/pip-pYu5Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:43 INFO - Running setup.py (path:/tmp/pip-_QpfSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:43 INFO - Running setup.py (path:/tmp/pip-qTm2ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:43 INFO - Running setup.py install for manifestparser 11:15:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:43 INFO - Running setup.py install for mozcrash 11:15:43 INFO - Running setup.py install for mozdebug 11:15:43 INFO - Running setup.py install for mozdevice 11:15:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:43 INFO - Running setup.py install for mozfile 11:15:43 INFO - Running setup.py install for mozhttpd 11:15:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozinfo 11:15:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozInstall 11:15:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozleak 11:15:44 INFO - Running setup.py install for mozlog 11:15:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for moznetwork 11:15:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozprocess 11:15:44 INFO - Running setup.py install for mozprofile 11:15:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozrunner 11:15:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:44 INFO - Running setup.py install for mozscreenshot 11:15:45 INFO - Running setup.py install for moztest 11:15:45 INFO - Running setup.py install for mozversion 11:15:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:45 INFO - Cleaning up... 11:15:45 INFO - Return code: 0 11:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:45 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:45 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 11:15:45 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 11:15:45 INFO - Using env: {'DISPLAY': ':0', 11:15:45 INFO - 'HOME': '/home/cltbld', 11:15:45 INFO - 'LANG': 'en_US.UTF-8', 11:15:45 INFO - 'LANGUAGE': 'en_US:en', 11:15:45 INFO - 'LOGNAME': 'cltbld', 11:15:45 INFO - 'MAIL': '/var/mail/cltbld', 11:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:45 INFO - 'MOZ_NO_REMOTE': '1', 11:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:45 INFO - 'NO_EM_RESTART': '1', 11:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:45 INFO - 'PWD': '/builds/slave/test', 11:15:45 INFO - 'SHELL': '/bin/bash', 11:15:45 INFO - 'SHLVL': '1', 11:15:45 INFO - 'TERM': 'linux', 11:15:45 INFO - 'TMOUT': '86400', 11:15:45 INFO - 'USER': 'cltbld', 11:15:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:45 INFO - '_': '/tools/buildbot/bin/python'} 11:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:45 INFO - Running setup.py (path:/tmp/pip-i4h9EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:45 INFO - Running setup.py (path:/tmp/pip-dtBRba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:45 INFO - Running setup.py (path:/tmp/pip-B4zVRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:45 INFO - Running setup.py (path:/tmp/pip-BauCEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:45 INFO - Running setup.py (path:/tmp/pip-9OH07A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:45 INFO - Running setup.py (path:/tmp/pip-EDOmEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:45 INFO - Running setup.py (path:/tmp/pip-4axjjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:45 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)) 11:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:45 INFO - Running setup.py (path:/tmp/pip-xdoPWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:46 INFO - Running setup.py (path:/tmp/pip-3Nwlky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:46 INFO - Running setup.py (path:/tmp/pip-_vdBCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:46 INFO - Running setup.py (path:/tmp/pip-FqwxBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:46 INFO - Running setup.py (path:/tmp/pip-G7IebK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:46 INFO - Running setup.py (path:/tmp/pip-K3QT6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:46 INFO - Running setup.py (path:/tmp/pip-Viqx_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:46 INFO - Running setup.py (path:/tmp/pip-C3XHts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:46 INFO - Running setup.py (path:/tmp/pip-XMNcdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:46 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)) 11:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:46 INFO - Running setup.py (path:/tmp/pip-BFB29e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:46 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)) 11:15:46 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)) 11:15:46 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)) 11:15:46 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)) 11:15:46 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)) 11:15:46 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)) 11:15:46 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)) 11:15:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:47 INFO - Downloading blessings-1.6.tar.gz 11:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:47 INFO - Installing collected packages: blessings 11:15:47 INFO - Running setup.py install for blessings 11:15:47 INFO - Successfully installed blessings 11:15:47 INFO - Cleaning up... 11:15:47 INFO - Return code: 0 11:15:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:48 INFO - Reading from file tmpfile_stdout 11:15:48 INFO - Current package versions: 11:15:48 INFO - argparse == 1.2.1 11:15:48 INFO - blessings == 1.6 11:15:48 INFO - blobuploader == 1.2.4 11:15:48 INFO - docopt == 0.6.1 11:15:48 INFO - functools32 == 3.2.3-2 11:15:48 INFO - jsonschema == 2.5.1 11:15:48 INFO - manifestparser == 1.1 11:15:48 INFO - mozInstall == 1.13 11:15:48 INFO - mozcrash == 1.0 11:15:48 INFO - mozdebug == 0.1 11:15:48 INFO - mozdevice == 0.51 11:15:48 INFO - mozfile == 1.2 11:15:48 INFO - mozhttpd == 0.7 11:15:48 INFO - mozinfo == 0.10 11:15:48 INFO - mozleak == 0.1 11:15:48 INFO - mozlog == 3.5 11:15:48 INFO - moznetwork == 0.27 11:15:48 INFO - mozprocess == 0.25 11:15:48 INFO - mozprofile == 0.28 11:15:48 INFO - mozrunner == 6.13 11:15:48 INFO - mozscreenshot == 0.1 11:15:48 INFO - mozsystemmonitor == 0.3 11:15:48 INFO - moztest == 0.8 11:15:48 INFO - mozversion == 1.4 11:15:48 INFO - psutil == 3.1.1 11:15:48 INFO - requests == 1.2.3 11:15:48 INFO - wsgiref == 0.1.2 11:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:48 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 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:48 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 11:15:48 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 11:15:48 INFO - Using env: {'DISPLAY': ':0', 11:15:48 INFO - 'HOME': '/home/cltbld', 11:15:48 INFO - 'LANG': 'en_US.UTF-8', 11:15:48 INFO - 'LANGUAGE': 'en_US:en', 11:15:48 INFO - 'LOGNAME': 'cltbld', 11:15:48 INFO - 'MAIL': '/var/mail/cltbld', 11:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:48 INFO - 'MOZ_NO_REMOTE': '1', 11:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:48 INFO - 'NO_EM_RESTART': '1', 11:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:48 INFO - 'PWD': '/builds/slave/test', 11:15:48 INFO - 'SHELL': '/bin/bash', 11:15:48 INFO - 'SHLVL': '1', 11:15:48 INFO - 'TERM': 'linux', 11:15:48 INFO - 'TMOUT': '86400', 11:15:48 INFO - 'USER': 'cltbld', 11:15:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:48 INFO - '_': '/tools/buildbot/bin/python'} 11:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 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)) 11:15:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:15:49 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)) 11:15:49 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)) 11:15:49 INFO - Installing collected packages: simplejson 11:15:49 INFO - Running setup.py install for simplejson 11:15:49 INFO - building 'simplejson._speedups' extension 11:15:49 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 11:15:50 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 11:15:50 INFO - Successfully installed simplejson 11:15:50 INFO - Cleaning up... 11:15:50 INFO - Return code: 0 11:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', '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 11:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:15:50 INFO - Using env: {'DISPLAY': ':0', 11:15:50 INFO - 'HOME': '/home/cltbld', 11:15:50 INFO - 'LANG': 'en_US.UTF-8', 11:15:50 INFO - 'LANGUAGE': 'en_US:en', 11:15:50 INFO - 'LOGNAME': 'cltbld', 11:15:50 INFO - 'MAIL': '/var/mail/cltbld', 11:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:50 INFO - 'MOZ_NO_REMOTE': '1', 11:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:50 INFO - 'NO_EM_RESTART': '1', 11:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:50 INFO - 'PWD': '/builds/slave/test', 11:15:50 INFO - 'SHELL': '/bin/bash', 11:15:50 INFO - 'SHLVL': '1', 11:15:50 INFO - 'TERM': 'linux', 11:15:50 INFO - 'TMOUT': '86400', 11:15:50 INFO - 'USER': 'cltbld', 11:15:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:50 INFO - '_': '/tools/buildbot/bin/python'} 11:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:50 INFO - Cleaning up... 11:15:50 INFO - Return code: 0 11:15:50 INFO - Running post-action listener: _resource_record_post_action 11:15:50 INFO - Running post-action listener: _start_resource_monitoring 11:15:50 INFO - Starting resource monitoring. 11:15:50 INFO - [mozharness: 2017-09-09 18:15:50.902119Z] Finished create-virtualenv step (success) 11:15:50 INFO - [mozharness: 2017-09-09 18:15:50.902626Z] Running install step. 11:15:50 INFO - Running pre-action listener: _resource_record_pre_action 11:15:50 INFO - Running main action method: install 11:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:51 INFO - Reading from file tmpfile_stdout 11:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:51 INFO - Reading from file tmpfile_stdout 11:15:51 INFO - Output received: 11:15:51 INFO - Usage: mozinstall [options] installer 11:15:51 INFO - Options: 11:15:51 INFO - -h, --help show this help message and exit 11:15:51 INFO - -d DEST, --destination=DEST 11:15:51 INFO - Directory to install application into. [default: 11:15:51 INFO - "/builds/slave/test"] 11:15:51 INFO - --app=APP Application being installed. [default: firefox] 11:15:51 INFO - mkdir: /builds/slave/test/build/application 11:15:51 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'] 11:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:16:07 INFO - Reading from file tmpfile_stdout 11:16:07 INFO - Output received: 11:16:07 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:07 INFO - Running post-action listener: _resource_record_post_action 11:16:07 INFO - [mozharness: 2017-09-09 18:16:07.816643Z] Finished install step (success) 11:16:07 INFO - [mozharness: 2017-09-09 18:16:07.816893Z] Running setup-mitmproxy step. 11:16:07 INFO - Running pre-action listener: _resource_record_pre_action 11:16:07 INFO - Running main action method: setup_mitmproxy 11:16:07 INFO - Skipping: mitmproxy is not required 11:16:07 INFO - Running post-action listener: _resource_record_post_action 11:16:07 INFO - [mozharness: 2017-09-09 18:16:07.818078Z] Finished setup-mitmproxy step (success) 11:16:07 INFO - [mozharness: 2017-09-09 18:16:07.818297Z] Running run-tests step. 11:16:07 INFO - Running pre-action listener: _resource_record_pre_action 11:16:07 INFO - Running pre-action listener: _set_gcov_prefix 11:16:07 INFO - Running main action method: run_tests 11:16:07 WARNING - Try message not found. 11:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:07 INFO - Python 2.7.3 11:16:07 INFO - Return code: 0 11:16:07 INFO - grabbing minidump binary from tooltool 11:16: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')]} 11:16:07 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 0x1e5a090>, '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 0x1e5ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:07 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 11:16:07 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 11:16:07 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 11:16:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:07 INFO - Return code: 0 11:16:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:07 INFO - ENV: RUST_BACKTRACE is now full 11:16:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:16:07 INFO - Using env: {'DISPLAY': ':0', 11:16:07 INFO - 'HOME': '/home/cltbld', 11:16:07 INFO - 'LANG': 'en_US.UTF-8', 11:16:07 INFO - 'LANGUAGE': 'en_US:en', 11:16:07 INFO - 'LOGNAME': 'cltbld', 11:16:07 INFO - 'MAIL': '/var/mail/cltbld', 11:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:07 INFO - 'MOZ_NO_REMOTE': '1', 11:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:07 INFO - 'NO_EM_RESTART': '1', 11:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:07 INFO - 'PWD': '/builds/slave/test', 11:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:07 INFO - 'RUST_BACKTRACE': 'full', 11:16:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:07 INFO - 'SHELL': '/bin/bash', 11:16:07 INFO - 'SHLVL': '1', 11:16:07 INFO - 'TERM': 'linux', 11:16:07 INFO - 'TMOUT': '86400', 11:16:07 INFO - 'USER': 'cltbld', 11:16:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:07 INFO - '_': '/tools/buildbot/bin/python'} 11:16:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:16:08 INFO - mozversion application_buildid: 20170909172127 11:16:08 INFO - mozversion application_changeset: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 11:16:08 INFO - mozversion application_display_name: Nightly 11:16:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:08 INFO - mozversion application_name: Firefox 11:16:08 INFO - mozversion application_remotingname: firefox 11:16:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:16:08 INFO - mozversion application_vendor: Mozilla 11:16:08 INFO - mozversion application_version: 57.0a1 11:16:08 INFO - mozversion platform_buildid: 20170909172127 11:16:08 INFO - mozversion platform_changeset: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 11:16:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:16:08 INFO - mozversion platform_version: 57.0a1 11:16:08 INFO - using testdate: 1504980968 11:16:08 INFO - actual date: 1504980968 11:16:08 INFO - starting webserver on 'localhost:47876' 11:16:08 INFO - SUITE-START | Running 2 tests 11:16:08 INFO - TEST-START | dromaeo_css 11:16:08 INFO - Initialising browser for dromaeo_css test... 11:16:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47876/getInfo.html -profile /tmp/tmpbaIPHe/profile 11:16:08 INFO - TEST-INFO | started process 10112 (/builds/slave/test/build/application/firefox/firefox http://localhost:47876/getInfo.html) 11:16:14 INFO - TEST-INFO | 10112: exit 0 11:16:14 INFO - Browser initialized. 11:16:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:14 INFO - Using env: {'DISPLAY': ':0', 11:16:14 INFO - 'HOME': '/home/cltbld', 11:16:14 INFO - 'JSGC_DISABLE_POISONING': '1', 11:16:14 INFO - 'LANG': 'en_US.UTF-8', 11:16:14 INFO - 'LANGUAGE': 'en_US:en', 11:16:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:16:14 INFO - 'LOGNAME': 'cltbld', 11:16:14 INFO - 'MAIL': '/var/mail/cltbld', 11:16:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:14 INFO - 'MOZ_CRASHREPORTER': '1', 11:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:16:14 INFO - 'MOZ_NO_REMOTE': '1', 11:16:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:14 INFO - 'NO_EM_RESTART': '1', 11:16:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:14 INFO - 'PWD': '/builds/slave/test', 11:16:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:14 INFO - 'RUST_BACKTRACE': 'full', 11:16:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:14 INFO - 'SHELL': '/bin/bash', 11:16:14 INFO - 'SHLVL': '1', 11:16:14 INFO - 'TERM': 'linux', 11:16:14 INFO - 'TMOUT': '86400', 11:16:14 INFO - 'USER': 'cltbld', 11:16:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:14 INFO - '_': '/tools/buildbot/bin/python'} 11:16:14 INFO - TEST-INFO | started process 10313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbaIPHe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:15 INFO - PID 10313 | 11:16:15 INFO - PID 10313 | (/builds/slave/test/build/application/firefox/firefox:10364): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:16:15 INFO - PID 10313 | 11:16:25 INFO - PID 10313 | RSS: Main: 174092288 11:16:25 INFO - PID 10313 | 11:19:22 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47876/tests/dromaeo/cssquery-ext.html) 11:19:24 INFO - PID 10313 | RSS: Main: 175443968 11:19:24 INFO - PID 10313 | 11:22:26 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-ext.html (next: http://localhost:47876/tests/dromaeo/cssquery-jquery.html) 11:22:26 INFO - PID 10313 | RSS: Main: 172167168 11:22:26 INFO - PID 10313 | 11:25:28 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47876/tests/dromaeo/cssquery-mootools.html) 11:25:29 INFO - PID 10313 | RSS: Main: 172642304 11:25:29 INFO - PID 10313 | 11:28:30 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47876/tests/dromaeo/cssquery-prototype.html) 11:28:31 INFO - PID 10313 | RSS: Main: 172843008 11:28:31 INFO - PID 10313 | 11:31:34 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47876/tests/dromaeo/cssquery-yui.html) 11:31:35 INFO - PID 10313 | RSS: Main: 174538752 11:31:35 INFO - PID 10313 | 11:34:36 INFO - PID 10313 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-yui.html (next: http://localhost:47876/tests/dromaeo/cssquery-dojo.html) 11:34:37 INFO - PID 10313 | RSS: Main: 176697344 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | __start_tp_report 11:34:37 INFO - PID 10313 | _x_x_mozilla_page_load 11:34:37 INFO - PID 10313 | _x_x_mozilla_page_load_details 11:34:37 INFO - PID 10313 | |i|pagename|runs| 11:34:37 INFO - PID 10313 | |0;dojo.html;3070.861811218495;3099.5195744659572;3102.9689703102963;3150.1809529522316;3179.157523256339;6195.2255968004;6292.874142517158;6382.4255816976465;6407.455366293871;6437.227532696077;6269.028300613412;6281.309056003836;6386;6442.355764423555;6472.773452929148;5838.657108864963;5851.502622277111;5887.4995625371785;5924.674142922137;5943.019401798698;5846.824595262127;5889.734961926723;5903.35063143054;6012.068129439944;6034.969825150868;5710.800121995731;5749.568782341341;5794.362620111805;5803.883922321572;5858.2677165354335;5710.2576665033275;5763.164341170549;5789.015867302569;5795.710214489259;5892.469677729025;5787.884242315172;5794.188813566104;5847.532197424196;5858.443447872445;5874.089516125007;6183.1034499997695;6263.874722505524;6312.558120931537;6375.075614035985;6424.1327420798525;6729.394354508069;6856.588604683735;6859.9314006859795;6861.039454476378;6868.862622747567;6809.625470599115;6834.179898412172;6838.14523184602;6895.896561551581;6950.895736563955;6283.371662833726;6345.96827015862;6347.39699728525;6357.11000459936;6358.078078678612;6836.829079273058;6922.723091076401;6931.306869313028;6971.442284617218;6976.4767642426;6579.934200658028;6606.942889137715;6631.171103612049;6659.367360100783;6668.199816022011;6712.328767123248;6715.227748808949;6754.966225168842;6812.352826481477;6838.418734407532;6711.127553418024;6739.865202695919;6781.559198652072;6785.558938668971;6787.966060169766;6636.104125943032;6693.698783554752;6725.495587830835;6743.797686069426;6748.662566871735;5302.204669299559;5334.5732341412595;5354.196870469461;5365.839024829262;5395.514403703685;4644.326572646947;4659.743714095689;4686.554777296152;4692.601128904013;4725.220338644085;5688.11834165705;5762.020456522401;5814.94185058144;5877.4122587740885;5886.440788125121;6759.087523184406;6807.693653785592;6816.659167041727;6823.55646882951;6829.453643708492;5748.827535173951;5755.424457554211;5756.827295181151;5759.625624334405;5764.769409223584;5704.372519022904;5721.828345149652;5728.51307638847;5794.565407594448;5821.476067153976;6072.483838873657;6180.443760061616;6382.648954307558;6437.67811609427;6515.641639709862;6608.074869518367;6662.16722909646;6667.099941507834;6699.497537684791;6714.0600315954825;6522.28254891971;6567.605943643397;6585.506087043395;6651;6653.767118150841;6721.193456785217;6762.695678694372;6813.04617353561;6836.350546698056;6837.35045170708;6768.052472653931;6793;6830.248672645906;6874.381305682513;6899.517033807585;6375.808725738235;6457.0637257596445;6463.676816159267;6470.158879345655;6473.126127972663;6404.583702059351;6407.135036769976;6431.453326467303;6504.804855854332;6534.9217379131915;6530.8040758777315;6534.215894092549;6539.149910511603;6545.2800191979795;6594.8351291218105;6623.4038936495945;6646.8005959821285;6649.2685804562425;6694.895342268666;6742.595444273359;6222.28443728977;6326.810195694136;6381.106645069787;6439.291677915519;6474.935250647433 11:34:37 INFO - PID 10313 | |1;ext.html;862.2455351567379;884.3279107878011;885.8582626779717;891.9152680495355;898.0929261445938;40841.3873791893;41650.58349416505;41797.58202417975;41806.16387672252;41900.58099419001;37134.8143259284;37339.813300933456;37369.81315093428;37371.252574948485;37420.62579374205;6987.30126987301;7086.078809754725;7089.113860767404;7097;7108.0048793169;6956.65216739161;7023.227444981048;7024.367806897379;7027.859442811141;7029.367356937874;7599.962000189991;7839.333656639193;7880.290773830354;7882.172371900954;7884.211578842099;7639.388848892076;7714.884276735854;7783.922160778405;7798.298153166185;7801.765947021541;7516.135644400909;7660.885086723703;7721.845563088763;7737.381009519281;7741.806454838674;37179.4423083654;37475.437868431996;37490.43764343537;37573.43639845405;37592.248155036745;3487.877924272638;3547.9822600887087;3550.8757193498104;3551.271989242199;3553.1650062235353;30951;31064.068077957698;31084.533731994037;31100.533491997638;31171.220719481968;5270.420253772082;5276.657017293902;5295;5312.76092575835;5327.38735045467;174593.1270343653;174939;175549;175697.99999999872;176234;41668;42473.36289955653;42643.36034959478;49956;50350;51559.48440515547;51860.22209666858;51899;51900.48099519032;51936;14002.43990240379;14180.787288190686;14185.78721319181;14190.716185676436;14262.57212283633;10987.121030317556;11133.610323638633;11143.777124457627;11172.720681983015;11256.718582035515;13700.588982330546;13775.242361670204;13957.860421395859;14001.29993500321;14070.437182512585;5565.052231718866;5600.355514722456;5601.691906945157;5695.515881150149;5776.451237132465;997.9251556133319;1000.9949950250348;1002.5839276700087;1004.6634377483625;1012.7492546704814;22491.437714056952;22523.774762252495;22566;22902.198423055448;22959;1089;1094.8905109488987;1100.8733995590449;1104.282216559243;1114.8662160540787;11934.403279835973;12088.75822483563;12092.57675981354;12302.938485307515;12367.257964522158;216887;220026;220574;221092;221479;53867.73066134644;54035.459645403826;54308.45691543113;54370.45629543733;54413.45586544163;1438.3167995202195;1466.3254902744643;1472.9263536823116;1481.525911708243;1490.0314795383088;22403.32790016302;22565.8871705647;22711.659325110468;22844.200452984067;22855;38207.808960955015;38218.42672359861;38227.42658860064;38253;38300.80849595734;186563;186734;187060;187380;188059.0597047006;30351.544726828673;30857.8457107722;34789.82605086958;35058.123546911535;35091.29817403587;43767.78116109399;43978.34032489451;44030.55969440265;44056;44256.336154957055;31496.842515787273;31779.36441271208;31886.84056579702;31985.36029279355;32480.512792308607;31645.841770790998;31647.36705265928;31701.20746981344;31708;31713;35526;36364.63635363719;36452.63547364598;36694;36934.44598331081;30817.229569260948;31190.532142017433;31359;31883.68116318807;32478.350432990734;22933.426664333525;23108.768912311334;23309.41726456852;23732.644010340206;23859.164929227394 11:34:37 INFO - PID 10313 | |2;jquery.html;564.556822894028;565.5701666733281;566.7534622439237;585.8213244960288;600.7867207141464;21737.456563585918;22249.2212772553;22371.888140559317;22393;22411;21739.456513587167;22031.559368812614;22214.11143554256;24515.509689806193;24879.253622391312;6355;6397.6801159941815;6410.102585638015;6418.903716444257;6480.092787009822;6149.815505534841;6310.621362718229;6405.42351188393;6410.871782564346;6413.583117097397;6346.682665866688;6378.521610879179;6382.808515744535;6396.424321811036;6408;6384.170057892491;6394.040893865911;6403.679816009181;6406.551541392105;6409.294977552466;5910.290765108214;5935.643861368331;5936.7328470218945;5941.851453713649;5957.642541447483;26682;27457.17628471129;27968.720312796817;28025.159245222676;28230.15309540717;2038.3579172560596;2082.333653230967;2084.0205103601284;2093.1418118571464;2094.2356040045424;18667.813321866743;19295.324663636704;19321.51696207606;19348.903255483772;19362.322318718776;2347.6713260143592;2367.30164601443;2408.5303365843665;2412.867292298923;2415.058127330325;107298.46350768274;111782.44108779404;123455;129878.99999999905;133681;14015.649608759863;14313.427462901367;14331.498397556035;14494.202818845064;14501.927490362481;22138.88930555337;22224.88887555552;22340;22341.888290558443;22405.32784016482;9604.711858644252;9964.750881227883;9973.351732137387;10030.191546367028;10106.797864042825;9418;9465.432074075577;9471.289653276031;9517.714468565953;9595.23238140947;8677.869831952527;8753.824923501494;8811.955940220258;8933.642654293886;9025.864612030824;2650.271175426773;2659.4415172813924;2687.9462410751676;2757.903473378422;2816.4226333601564;969.8981606931312;974.449436068619;982.7543114221445;992.3004281981185;1011.7369483934083;18491.260349586137;18713.90643046776;18748.625027499373;18844.623107537773;19187.520311992314;1017.4404077757204;1029.9176065914858;1035.6478797208986;1035.9792804143874;1045.8222102242637;10514.421706806199;10523.368597884151;10587.682369528773;10590.682279531626;10983.780324393627;409598;420751;426894;431460;435180;103017;104385.95614043763;104525.47737261264;107910.46044769726;109714.45142774234;1144.5879483385975;1155.7399585093456;1168.3457263932225;1236.975260494785;1241.3793103448277;19890;19950.700739488628;20361;20459.693104603146;20503.79496205019;53717.92564148773;54353;55073.44926550683;55662.886742265735;56584.43415565956;67127.3287267121;67397;67430.66284668545;67820.32179678338;67999.66000169968;13598.456061757815;14008.579742607739;14089.084209526349;14102.083364581269;14123.364448599632;21827.126914923225;22003;22150.446238844157;22173.556528869656;22222.111115555195;17516.82483175152;17723.645527089127;17867.374641887473;18019.639607208046;18025.2789888403;14849.886258530438;16245.837541624905;16415.26131324117;16659.416920407726;16929.407470738464;16202.756958645865;17436.82563174352;17984.10079496046;17989.64020719552;18223.45329640113;13920.651983700489;13963.720725585634;14004.719905601627;14024.368903399576;14082.859171408565;17085.145742712564;17218.655626887143;17594.38419655306;17731.468055958343;17812.732809007615 11:34:37 INFO - PID 10313 | |3;mootools.html;1352.1346338343458;1398.6573289544058;1415.7805540141283;1417.3621870158431;1427.5146450206928;15011.849881501183;15680.451184208556;15686.764698529518;15699;15701.450449234278;15220.162891040989;15352;15352.769708454382;15364.6927061459;15365.923170384132;2718.864056797157;2788.888444462229;2796.3149028487946;2796.4407118576364;2801.9859900700467;2722.9863850680717;2796.8601569921525;2801.3276813564803;2809.101087651952;2810.12886005339;2654.986725066372;2749.2714430675887;2850.558163484663;2852.215640698804;2853.957190642142;2797.776177905783;2813.22636275024;2818.591304260871;2824.844633545154;2841.403305305878;2624.7375262473793;2791.2184588315304;2794.315392728774;2798.4822807780624;2799.1042866282796;15143.924280378527;15221.695566088616;15234.162121083336;15236.923815380964;15249.466268680542;7975.641096150687;8246.876296855551;8258.8348233035;8259.297959673375;8261.876071858927;5389.649672771257;5467.644603100785;5528.530074943635;5597.216389705444;5607.102863541813;1844.124041080476;1845.243450185431;1860.2094110003195;1912.6557219700449;1913.0912816412233;25972.87013564939;26176.34559136037;26258;27466.17601471959;27484.312892177655;6913.170419549686;6918.446524278046;6940.09778728762;7112.395446387115;7172.0676312079095;17240.65518689619;17247.65504689899;17284.913575432292;17306.307747690204;17308.65382692339;7526.849463010819;7553.055868016498;7558.773236802905;7561.697532098655;7562.054743157106;6823.658817059128;6889.793306200822;6938.548994315353;6963.512554121265;6988.091548098816;4963.553280204726;5108.386993560722;5125.384953805567;5135.229715542624;5155.7679904404395;1372.4647387518876;1376.6440056544295;1380.2063813307389;1389.4928351151757;1396.553103007028;883.7746374674546;898.5552151684958;903.3947255338938;906.2478143141177;913.0641092879852;7360.77917662471;7445.813854653677;7493.100827900686;7528.134264559536;7609.239076092346;722.7000794670153;729.1578227147653;729.711763853275;737.4837613670452;746.8468963862396;4917.237828136645;5073.746312684351;5107.974460127675;5205.427402985669;5290.047791397508;21445.249416270668;21864.89067554652;22272.888635557043;22343.32970010902;22360.776392236196;20886;21940.122395104336;21989.780102199093;22121;22170.44573885666;9297.209737172281;9629.229661627052;10774.461276935965;10916.399598022184;11073;8995.595198215966;9000.964889037845;9052.547372631474;9097.909020909707;9119.589618467318;17861.196246168693;18503.167357469214;18609.720854186926;18755.156017978952;18778.624427511648;18578.163982621085;18854.434366969013;18968.620627587647;19061.714074289175;19219.711704324727;10695.518701658288;10795.73010674708;10875.347479151276;10889.401082940514;10901.618443354444;13673.589792306248;13683.315834208448;13795.241261730702;13814.240216787772;13819.723605527632;11269.549218031514;11505.194636375374;11516.251443656136;11637.5344986203;11665.59170429065;10691.786164276826;10698.518566664363;10712.785744284914;10748.301360411548;10997.725056873322;10002;10267.537960791931;10273.897261027592;10278.074973252444;10283.537240824031;6853.828654283483;6854.794356169323;6910.896336555056;6926.965365173141;6961.269066747918;7195.892061618975;7273.8908916365235;7301.598412087386;7375.594342311009;7405.7778266652085 11:34:37 INFO - PID 10313 | |4;prototype.html;496.251093226418;498.7458010004253;516.1560848013497;516.643515973978;526.6945171800356;6210.347913469082;6345.270293916195;6376.866622368992;6421.67891605419;6430.810300094486;6175.444210021097;6186.7525298987985;6204;6213.502919766419;6258.561900666955;4864.659473836833;4960.553550180483;4975.701457912528;4990.053878987198;5019.874503137433;5001.974990125044;5070.645054846163;5094.872628184306;5121.385433747955;5123.4108077571;4960.2559616057515;4973.776180071887;5002.349694539705;5035.899282014358;5042.369703787027;4943.6539442239055;4964.776585053663;4994.700317980933;5001.199808030698;5029.295898574166;4475.239209334389;4483.49802816057;4484.865454036384;4496.168208881335;4530.252508336121;6100.96949515254;6219.937800621981;6268.717907694165;6288.402601752826;6299;5648.8870222595315;5682.232898558683;5692.715364231772;5702.800401985911;5710;6498.5126115541525;6502.902456463157;6538.346165383471;6569.981652843817;6666.566673166229;4872.634552408548;4898.118338699032;4901.485344038896;4903.896623259774;4911.312416261726;6758;6844.931550684529;6846.554973926679;6848.417884479825;7033.331833475862;4944.085344211332;4967.950320496749;4992.925106123411;5044;5061.746912654353;5070.340855688811;5080.288759573663;5089.9745501273;5093.719845408538;5122.1804511278015;5627.971860140755;5649.435056494318;5681.375048744635;5689.231953686282;5724.055530837449;6333.778317758856;6357.936420635827;6572.80281591553;6594.571352862049;6637.269900310962;1732.9133543322782;1737.3311275159156;1750.1074452029302;1753.8509226715616;1768.7789026371704;1202.482932339085;1208.2871106047473;1218.7257866979858;1220.7924652809045;1223.8837310455492;5673.943260567424;5739.49449682006;5743;5812.837432513515;5842.474177324061;6900.896486552706;6912.516123871382;6917.169939607279;6928.549644273106;6953.269906659829;5832.766689332379;5834.708264586839;5841.50347220491;5863.442972917566;5880.941190588125;3606.314800187956;3621.8913432597064;3650.324689932371;3675.1363429594026;3691.6308369163407;6508.576942498722;6603.151117687055;6620.86758264832;6629.668516574152;6653.334666533405;6903.965480172667;6941.34057264559;6946.714857751333;7044.22513523512;7076.32774886385;6558.639274839834;6566.6388348641285;6573.3098024706715;6606.669666516655;6636.236832764197;6838.863222735617;6848.794536163923;6924.58452492852;6944.687489062903;6977.755778547727;6750.291219422086;6804.4216241620015;6817.136802542845;6831.555948863308;6878.8624227516175;6621.404073633396;6647.135872336566;6669.7665581704405;6670.599764014175;6706.731730730911;4948.35671362735;4956.3804524434445;4982.377202849644;5007.899842003212;5041.218611115283;6586.637734924625;6801.727930882709;6855.503693116447;6882.655867206719;6950.860982780215;6384.233891932998;6573.112629794917;6574.901376479261;6586.967065164644;6600.735970561316;6483.481321494363;6520.152380190734;6555.2789193187755;6572.309907459648;6611.305812889577;6415.647139407378;6451.387118223761;6470.352964703492;6507;6540.967295163494;6559.376859198369;6600.471962242913;6632.303608121078;6633.170853643294;6654.800355989328;6313.842153946188;6345.365463453618;6368.630744389979;6425.453836423956;6427.614343139239 11:34:37 INFO - PID 10313 | |5;yui.html;812.4597142899972;841.0286119531941;892.7187935800223;905.3074398085462;933.7012156110043;19357.903210483946;20343.287984920513;20357.389278321654;20364.08361623727;20397.796022039776;17942.641147177048;18218.362357317495;18352.81647183528;19199.808001919977;19240.807591924076;911.0252030327536;936.4802534593298;939.8825146856609;943.8820147481565;944.1832814615377;956.115593076405;994.7910938702881;998.181491177235;1001.8397056470966;1002.1832206751474;1036.3367444835312;1042.2547878267037;1046.4610725476387;1047.5914393386586;1048.088163297928;1030.1141018723893;1030.6907927621683;1032.0247366238907;1032.210359075308;1032.2258306270335;722.1370462297557;743.605888878895;750.6922161913644;751.6730222353294;765.3571000359725;20165.596688066304;20370.388888333375;20372.490687732778;20399.592008159754;20419.2853250137;21178.152873885025;21367;21822;21909;21931.890340548354;17455.21451534684;17589.912050439794;17684.823151768447;18030;18070.457886263433;3636.7454278200535;3662.285854258421;3664.992127165024;3672.247189326182;3673.5040769496045;141936;142838.57161428357;143861.2806935969;145186;148017;16076.839231607533;16615.08617026051;16731;16774.49676509707;16809.49571512832;30877.382452350826;30932.22669433282;31776.36447271088;31889.840550797562;31946;8106.83786324282;8282.088970213272;8283;8289.839422480858;8291.917080829115;3904.7266691331333;4234.280172370704;4292.248856450109;4326.58897404746;4331.371951067078;5114.3862736471865;5226.477352264743;5240.528352448298;5245.318108645852;5249.973750131225;921.1939552891221;948.037741692183;956.3353469338882;958.6261358070358;960.8318544254728;585.771549095853;587.3891153200624;597.2206270816539;598.335847209597;628.4563852267755;11268.718282043015;11414.828777568344;11640.708982275512;12180.878191218151;12260.570880019335;669.9397054265042;677.847484316025;678.8099332186996;694.9200841903145;698.5389642835704;5192.169252919514;5295.443978382292;5302.3637163540625;5349.010433069894;5355.651882627617;125638;128734;128860.65700763257;130935.34532327278;133518;106358;106709;107166.46416768023;107859;108077.45961270301;92218.0778192223;94221;97482;100263.49868250612;100468.99062018719;9719.611215551582;9946.104850563484;9996.550155243178;10017.14854237398;10028.29801913859;41884.37173442462;43066.354004689325;43284;43374.34938475862;43672.12655746804;56443;56676.716616416656;57113;57391.42608573861;58286.708566456895;14635.195064271142;14902.403903843724;14998;15151.469698560497;15155;16616.00303981765;16698.165091745606;16896.66206675835;17007.659846803243;17057;15261.23693815327;15420.84579154194;15464.072155670696;15542.766858496905;15566;14139.64650883736;14173.929130354281;14312.212828294543;14423.278836058365;14433;11287.774244515227;13988.440462381392;14473.782893256399;14494.275286235857;14496.637584060483;9893.159081478156;10247.7438064049;10395.168386528909;10638.73403164927;10750.516226769658;10614.840777388192;10739.248252622241;10922.12622990143;10998.230123891251;11091.389973551532 11:34:37 INFO - PID 10313 | __end_tp_report 11:34:37 INFO - PID 10313 | __start_cc_report 11:34:37 INFO - PID 10313 | _x_x_mozilla_cycle_collect,362 11:34:37 INFO - PID 10313 | __end_cc_report 11:34:37 INFO - PID 10313 | __startTimestamp1504982077080__endTimestamp 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | ------- Summary: start ------- 11:34:37 INFO - PID 10313 | Number of tests: 6 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#0] dojo.html Cycles:165 Average:6214.33 Median:6437.23 stddev:748.17 (11.6%) stddev-sans-first:708.66 11:34:37 INFO - PID 10313 | Values: 3070.9 3099.5 3103.0 3150.2 3179.2 6195.2 6292.9 6382.4 6407.5 6437.2 6269.0 6281.3 6386.0 6442.4 6472.8 5838.7 5851.5 5887.5 5924.7 5943.0 5846.8 5889.7 5903.4 6012.1 6035.0 5710.8 5749.6 5794.4 5803.9 5858.3 5710.3 5763.2 5789.0 5795.7 5892.5 5787.9 5794.2 5847.5 5858.4 5874.1 6183.1 6263.9 6312.6 6375.1 6424.1 6729.4 6856.6 6859.9 6861.0 6868.9 6809.6 6834.2 6838.1 6895.9 6950.9 6283.4 6346.0 6347.4 6357.1 6358.1 6836.8 6922.7 6931.3 6971.4 6976.5 6579.9 6606.9 6631.2 6659.4 6668.2 6712.3 6715.2 6755.0 6812.4 6838.4 6711.1 6739.9 6781.6 6785.6 6788.0 6636.1 6693.7 6725.5 6743.8 6748.7 5302.2 5334.6 5354.2 5365.8 5395.5 4644.3 4659.7 4686.6 4692.6 4725.2 5688.1 5762.0 5814.9 5877.4 5886.4 6759.1 6807.7 6816.7 6823.6 6829.5 5748.8 5755.4 5756.8 5759.6 5764.8 5704.4 5721.8 5728.5 5794.6 5821.5 6072.5 6180.4 6382.6 6437.7 6515.6 6608.1 6662.2 6667.1 6699.5 6714.1 6522.3 6567.6 6585.5 6651.0 6653.8 6721.2 6762.7 6813.0 6836.4 6837.4 6768.1 6793.0 6830.2 6874.4 6899.5 6375.8 6457.1 6463.7 6470.2 6473.1 6404.6 6407.1 6431.5 6504.8 6534.9 6530.8 6534.2 6539.1 6545.3 6594.8 6623.4 6646.8 6649.3 6694.9 6742.6 6222.3 6326.8 6381.1 6439.3 6474.9 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#1] ext.html Cycles:180 Average:36247.36 Median:3549.43 stddev:50569.34 (1424.7%) stddev-sans-first:50641.40 11:34:37 INFO - PID 10313 | Values: 862.2 884.3 885.9 891.9 898.1 40841.4 41650.6 41797.6 41806.2 41900.6 37134.8 37339.8 37369.8 37371.3 37420.6 6987.3 7086.1 7089.1 7097.0 7108.0 6956.7 7023.2 7024.4 7027.9 7029.4 7600.0 7839.3 7880.3 7882.2 7884.2 7639.4 7714.9 7783.9 7798.3 7801.8 7516.1 7660.9 7721.8 7737.4 7741.8 37179.4 37475.4 37490.4 37573.4 37592.2 3487.9 3548.0 3550.9 3551.3 3553.2 30951.0 31064.1 31084.5 31100.5 31171.2 5270.4 5276.7 5295.0 5312.8 5327.4 174593.1 174939.0 175549.0 175698.0 176234.0 41668.0 42473.4 42643.4 49956.0 50350.0 51559.5 51860.2 51899.0 51900.5 51936.0 14002.4 14180.8 14185.8 14190.7 14262.6 10987.1 11133.6 11143.8 11172.7 11256.7 13700.6 13775.2 13957.9 14001.3 14070.4 5565.1 5600.4 5601.7 5695.5 5776.5 997.9 1001.0 1002.6 1004.7 1012.7 22491.4 22523.8 22566.0 22902.2 22959.0 1089.0 1094.9 1100.9 1104.3 1114.9 11934.4 12088.8 12092.6 12302.9 12367.3 216887.0 220026.0 220574.0 221092.0 221479.0 53867.7 54035.5 54308.5 54370.5 54413.5 1438.3 1466.3 1472.9 1481.5 1490.0 22403.3 22565.9 22711.7 22844.2 22855.0 38207.8 38218.4 38227.4 38253.0 38300.8 186563.0 186734.0 187060.0 187380.0 188059.1 30351.5 30857.8 34789.8 35058.1 35091.3 43767.8 43978.3 44030.6 44056.0 44256.3 31496.8 31779.4 31886.8 31985.4 32480.5 31645.8 31647.4 31701.2 31708.0 31713.0 35526.0 36364.6 36452.6 36694.0 36934.4 30817.2 31190.5 31359.0 31883.7 32478.4 22933.4 23108.8 23309.4 23732.6 23859.2 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#2] jquery.html Cycles:180 Average:31746.79 Median:22193.83 stddev:71721.89 (323.2%) stddev-sans-first:71884.88 11:34:37 INFO - PID 10313 | Values: 564.6 565.6 566.8 585.8 600.8 21737.5 22249.2 22371.9 22393.0 22411.0 21739.5 22031.6 22214.1 24515.5 24879.3 6355.0 6397.7 6410.1 6418.9 6480.1 6149.8 6310.6 6405.4 6410.9 6413.6 6346.7 6378.5 6382.8 6396.4 6408.0 6384.2 6394.0 6403.7 6406.6 6409.3 5910.3 5935.6 5936.7 5941.9 5957.6 26682.0 27457.2 27968.7 28025.2 28230.2 2038.4 2082.3 2084.0 2093.1 2094.2 18667.8 19295.3 19321.5 19348.9 19362.3 2347.7 2367.3 2408.5 2412.9 2415.1 107298.5 111782.4 123455.0 129879.0 133681.0 14015.6 14313.4 14331.5 14494.2 14501.9 22138.9 22224.9 22340.0 22341.9 22405.3 9604.7 9964.8 9973.4 10030.2 10106.8 9418.0 9465.4 9471.3 9517.7 9595.2 8677.9 8753.8 8812.0 8933.6 9025.9 2650.3 2659.4 2687.9 2757.9 2816.4 969.9 974.4 982.8 992.3 1011.7 18491.3 18713.9 18748.6 18844.6 19187.5 1017.4 1029.9 1035.6 1036.0 1045.8 10514.4 10523.4 10587.7 10590.7 10983.8 409598.0 420751.0 426894.0 431460.0 435180.0 103017.0 104386.0 104525.5 107910.5 109714.5 1144.6 1155.7 1168.3 1237.0 1241.4 19890.0 19950.7 20361.0 20459.7 20503.8 53717.9 54353.0 55073.4 55662.9 56584.4 67127.3 67397.0 67430.7 67820.3 67999.7 13598.5 14008.6 14089.1 14102.1 14123.4 21827.1 22003.0 22150.4 22173.6 22222.1 17516.8 17723.6 17867.4 18019.6 18025.3 14849.9 16245.8 16415.3 16659.4 16929.4 16202.8 17436.8 17984.1 17989.6 18223.5 13920.7 13963.7 14004.7 14024.4 14082.9 17085.1 17218.7 17594.4 17731.5 17812.7 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#3] mootools.html Cycles:180 Average:9311.54 Median:27475.24 stddev:6726.33 (24.5%) stddev-sans-first:6718.62 11:34:37 INFO - PID 10313 | Values: 1352.1 1398.7 1415.8 1417.4 1427.5 15011.8 15680.5 15686.8 15699.0 15701.5 15220.2 15352.0 15352.8 15364.7 15365.9 2718.9 2788.9 2796.3 2796.4 2802.0 2723.0 2796.9 2801.3 2809.1 2810.1 2655.0 2749.3 2850.6 2852.2 2854.0 2797.8 2813.2 2818.6 2824.8 2841.4 2624.7 2791.2 2794.3 2798.5 2799.1 15143.9 15221.7 15234.2 15236.9 15249.5 7975.6 8246.9 8258.8 8259.3 8261.9 5389.6 5467.6 5528.5 5597.2 5607.1 1844.1 1845.2 1860.2 1912.7 1913.1 25972.9 26176.3 26258.0 27466.2 27484.3 6913.2 6918.4 6940.1 7112.4 7172.1 17240.7 17247.7 17284.9 17306.3 17308.7 7526.8 7553.1 7558.8 7561.7 7562.1 6823.7 6889.8 6938.5 6963.5 6988.1 4963.6 5108.4 5125.4 5135.2 5155.8 1372.5 1376.6 1380.2 1389.5 1396.6 883.8 898.6 903.4 906.2 913.1 7360.8 7445.8 7493.1 7528.1 7609.2 722.7 729.2 729.7 737.5 746.8 4917.2 5073.7 5108.0 5205.4 5290.0 21445.2 21864.9 22272.9 22343.3 22360.8 20886.0 21940.1 21989.8 22121.0 22170.4 9297.2 9629.2 10774.5 10916.4 11073.0 8995.6 9001.0 9052.5 9097.9 9119.6 17861.2 18503.2 18609.7 18755.2 18778.6 18578.2 18854.4 18968.6 19061.7 19219.7 10695.5 10795.7 10875.3 10889.4 10901.6 13673.6 13683.3 13795.2 13814.2 13819.7 11269.5 11505.2 11516.3 11637.5 11665.6 10691.8 10698.5 10712.8 10748.3 10997.7 10002.0 10267.5 10273.9 10278.1 10283.5 6853.8 6854.8 6910.9 6927.0 6961.3 7195.9 7273.9 7301.6 7375.6 7405.8 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#4] prototype.html Cycles:180 Average:5560.71 Median:6216.72 stddev:1570.82 (25.3%) stddev-sans-first:1528.54 11:34:37 INFO - PID 10313 | Values: 496.3 498.7 516.2 516.6 526.7 6210.3 6345.3 6376.9 6421.7 6430.8 6175.4 6186.8 6204.0 6213.5 6258.6 4864.7 4960.6 4975.7 4990.1 5019.9 5002.0 5070.6 5094.9 5121.4 5123.4 4960.3 4973.8 5002.3 5035.9 5042.4 4943.7 4964.8 4994.7 5001.2 5029.3 4475.2 4483.5 4484.9 4496.2 4530.3 6101.0 6219.9 6268.7 6288.4 6299.0 5648.9 5682.2 5692.7 5702.8 5710.0 6498.5 6502.9 6538.3 6570.0 6666.6 4872.6 4898.1 4901.5 4903.9 4911.3 6758.0 6844.9 6846.6 6848.4 7033.3 4944.1 4968.0 4992.9 5044.0 5061.7 5070.3 5080.3 5090.0 5093.7 5122.2 5628.0 5649.4 5681.4 5689.2 5724.1 6333.8 6357.9 6572.8 6594.6 6637.3 1732.9 1737.3 1750.1 1753.9 1768.8 1202.5 1208.3 1218.7 1220.8 1223.9 5673.9 5739.5 5743.0 5812.8 5842.5 6900.9 6912.5 6917.2 6928.5 6953.3 5832.8 5834.7 5841.5 5863.4 5880.9 3606.3 3621.9 3650.3 3675.1 3691.6 6508.6 6603.2 6620.9 6629.7 6653.3 6904.0 6941.3 6946.7 7044.2 7076.3 6558.6 6566.6 6573.3 6606.7 6636.2 6838.9 6848.8 6924.6 6944.7 6977.8 6750.3 6804.4 6817.1 6831.6 6878.9 6621.4 6647.1 6669.8 6670.6 6706.7 4948.4 4956.4 4982.4 5007.9 5041.2 6586.6 6801.7 6855.5 6882.7 6950.9 6384.2 6573.1 6574.9 6587.0 6600.7 6483.5 6520.2 6555.3 6572.3 6611.3 6415.6 6451.4 6470.4 6507.0 6541.0 6559.4 6600.5 6632.3 6633.2 6654.8 6313.8 6345.4 6368.6 6425.5 6427.6 11:34:37 INFO - PID 10313 | 11:34:37 INFO - PID 10313 | [#5] yui.html Cycles:180 Average:24379.90 Median:20371.44 stddev:36329.77 (178.3%) stddev-sans-first:36388.59 11:34:37 INFO - PID 10313 | Values: 812.5 841.0 892.7 905.3 933.7 19357.9 20343.3 20357.4 20364.1 20397.8 17942.6 18218.4 18352.8 19199.8 19240.8 911.0 936.5 939.9 943.9 944.2 956.1 994.8 998.2 1001.8 1002.2 1036.3 1042.3 1046.5 1047.6 1048.1 1030.1 1030.7 1032.0 1032.2 1032.2 722.1 743.6 750.7 751.7 765.4 20165.6 20370.4 20372.5 20399.6 20419.3 21178.2 21367.0 21822.0 21909.0 21931.9 17455.2 17589.9 17684.8 18030.0 18070.5 3636.7 3662.3 3665.0 3672.2 3673.5 141936.0 142838.6 143861.3 145186.0 148017.0 16076.8 16615.1 16731.0 16774.5 16809.5 30877.4 30932.2 31776.4 31889.8 31946.0 8106.8 8282.1 8283.0 8289.8 8291.9 3904.7 4234.3 4292.2 4326.6 4331.4 5114.4 5226.5 5240.5 5245.3 5250.0 921.2 948.0 956.3 958.6 960.8 585.8 587.4 597.2 598.3 628.5 11268.7 11414.8 11640.7 12180.9 12260.6 669.9 677.8 678.8 694.9 698.5 5192.2 5295.4 5302.4 5349.0 5355.7 125638.0 128734.0 128860.7 130935.3 133518.0 106358.0 106709.0 107166.5 107859.0 108077.5 92218.1 94221.0 97482.0 100263.5 100469.0 9719.6 9946.1 9996.6 10017.1 10028.3 41884.4 43066.4 43284.0 43374.3 43672.1 56443.0 56676.7 57113.0 57391.4 58286.7 14635.2 14902.4 14998.0 15151.5 15155.0 16616.0 16698.2 16896.7 17007.7 17057.0 15261.2 15420.8 15464.1 15542.8 15566.0 14139.6 14173.9 14312.2 14423.3 14433.0 11287.8 13988.4 14473.8 14494.3 14496.6 9893.2 10247.7 10395.2 10638.7 10750.5 10614.8 10739.2 10922.1 10998.2 11091.4 11:34:37 INFO - PID 10313 | -------- Summary: end -------- 11:34:37 INFO - PID 10313 | 11:34:37 INFO - TEST-INFO | 10313: exit 0 11:34:37 INFO - TEST-OK | dromaeo_css | took 1109582ms 11:34:37 INFO - TEST-START | kraken 11:34:37 INFO - Initialising browser for kraken test... 11:34:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47876/getInfo.html -profile /tmp/tmp8dlA4Q/profile 11:34:37 INFO - TEST-INFO | started process 10697 (/builds/slave/test/build/application/firefox/firefox http://localhost:47876/getInfo.html) 11:34:43 INFO - TEST-INFO | 10697: exit 0 11:34:43 INFO - Browser initialized. 11:34:43 INFO - Running cycle 1/1 for kraken test... 11:34:43 INFO - Using env: {'DISPLAY': ':0', 11:34:43 INFO - 'HOME': '/home/cltbld', 11:34:43 INFO - 'JSGC_DISABLE_POISONING': '1', 11:34:43 INFO - 'LANG': 'en_US.UTF-8', 11:34:43 INFO - 'LANGUAGE': 'en_US:en', 11:34:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:34:43 INFO - 'LOGNAME': 'cltbld', 11:34:43 INFO - 'MAIL': '/var/mail/cltbld', 11:34:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:43 INFO - 'MOZ_CRASHREPORTER': '1', 11:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:34:43 INFO - 'MOZ_NO_REMOTE': '1', 11:34:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:43 INFO - 'NO_EM_RESTART': '1', 11:34:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:43 INFO - 'PWD': '/builds/slave/test', 11:34:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:43 INFO - 'RUST_BACKTRACE': 'full', 11:34:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:43 INFO - 'SHELL': '/bin/bash', 11:34:43 INFO - 'SHLVL': '1', 11:34:43 INFO - 'TERM': 'linux', 11:34:43 INFO - 'TMOUT': '86400', 11:34:43 INFO - 'USER': 'cltbld', 11:34:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623', 11:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:43 INFO - '_': '/tools/buildbot/bin/python'} 11:34:43 INFO - TEST-INFO | started process 10897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8dlA4Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:44 INFO - PID 10897 | 11:34:44 INFO - PID 10897 | (/builds/slave/test/build/application/firefox/firefox:10948): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:34:44 INFO - PID 10897 | 11:34:54 INFO - PID 10897 | RSS: Main: 173121536 11:34:54 INFO - PID 10897 | 11:34:57 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:58 INFO - PID 10897 | RSS: Main: 177868800 11:34:58 INFO - PID 10897 | 11:35:01 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-dft) 11:35:01 INFO - PID 10897 | RSS: Main: 178614272 11:35:01 INFO - PID 10897 | 11:35:04 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-fft) 11:35:05 INFO - PID 10897 | RSS: Main: 174215168 11:35:05 INFO - PID 10897 | 11:35:07 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-oscillator) 11:35:08 INFO - PID 10897 | RSS: Main: 175165440 11:35:08 INFO - PID 10897 | 11:35:10 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:10 INFO - PID 10897 | RSS: Main: 175497216 11:35:10 INFO - PID 10897 | 11:35:14 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:14 INFO - PID 10897 | RSS: Main: 177954816 11:35:14 INFO - PID 10897 | 11:35:18 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:18 INFO - PID 10897 | RSS: Main: 177405952 11:35:18 INFO - PID 10897 | 11:35:21 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47876/tests/kraken/driver.html?testName=json-parse-financial) 11:35:22 INFO - PID 10897 | RSS: Main: 177897472 11:35:22 INFO - PID 10897 | 11:35:24 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:24 INFO - PID 10897 | RSS: Main: 177905664 11:35:24 INFO - PID 10897 | 11:35:26 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:26 INFO - PID 10897 | RSS: Main: 177307648 11:35:26 INFO - PID 10897 | 11:35:29 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:29 INFO - PID 10897 | RSS: Main: 174628864 11:35:29 INFO - PID 10897 | 11:35:32 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:33 INFO - PID 10897 | RSS: Main: 174657536 11:35:33 INFO - PID 10897 | 11:35:36 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:35:36 INFO - PID 10897 | RSS: Main: 174940160 11:35:36 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47876/tests/kraken/driver.html?testName=ai-astar) 11:35:38 INFO - PID 10897 | RSS: Main: 176541696 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | __start_tp_report 11:35:38 INFO - PID 10897 | _x_x_mozilla_page_load 11:35:38 INFO - PID 10897 | _x_x_mozilla_page_load_details 11:35:38 INFO - PID 10897 | |i|pagename|runs| 11:35:38 INFO - PID 10897 | |0;ai-astar;110;107;108;108;107;109;101;110;108;108 11:35:38 INFO - PID 10897 | |1;audio-beat-detection;122;117;115;119;116;131;120;116;142;123 11:35:38 INFO - PID 10897 | |2;audio-dft;163;165;163;162;165;162;164;165;166;166 11:35:38 INFO - PID 10897 | |3;audio-fft;74;74;74;76;79;75;74;74;74;75 11:35:38 INFO - PID 10897 | |4;audio-oscillator;85;85;84;79;79;80;80;80;80;82 11:35:38 INFO - PID 10897 | |5;imaging-gaussian-blur;115;114;110;114;110;115;113;114;114;114 11:35:38 INFO - PID 10897 | |6;imaging-darkroom;149;148;147;149;146;148;148;151;150;151 11:35:38 INFO - PID 10897 | |7;imaging-desaturate;99;94;95;95;93;96;94;94;94;96 11:35:38 INFO - PID 10897 | |8;json-parse-financial;58;55;53;53;54;54;55;53;52;54 11:35:38 INFO - PID 10897 | |9;json-stringify-tinderbox;37;38;37;37;37;40;39;38;37;37 11:35:38 INFO - PID 10897 | |10;stanford-crypto-aes;75;75;74;76;74;77;76;75;79;74 11:35:38 INFO - PID 10897 | |11;stanford-crypto-ccm;125;115;116;119;122;133;136;130;129;124 11:35:38 INFO - PID 10897 | |12;stanford-crypto-pbkdf2;180;169;173;170;171;187;172;180;174;170 11:35:38 INFO - PID 10897 | |13;stanford-crypto-sha256-iterative;64;64;64;68;69;67;64;73;63;66 11:35:38 INFO - PID 10897 | __end_tp_report 11:35:38 INFO - PID 10897 | __start_cc_report 11:35:38 INFO - PID 10897 | _x_x_mozilla_cycle_collect,914 11:35:38 INFO - PID 10897 | __end_cc_report 11:35:38 INFO - PID 10897 | __startTimestamp1504982138698__endTimestamp 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | ------- Summary: start ------- 11:35:38 INFO - PID 10897 | Number of tests: 14 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#0] ai-astar Cycles:10 Average:107.60 Median:108.00 stddev:2.55 (2.4%) stddev-sans-first:2.55 11:35:38 INFO - PID 10897 | Values: 110.0 107.0 108.0 108.0 107.0 109.0 101.0 110.0 108.0 108.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:121.00 stddev:8.44 (7.0%) stddev-sans-first:8.95 11:35:38 INFO - PID 10897 | Values: 122.0 117.0 115.0 119.0 116.0 131.0 120.0 116.0 142.0 123.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#2] audio-dft Cycles:10 Average:164.10 Median:165.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 11:35:38 INFO - PID 10897 | Values: 163.0 165.0 163.0 162.0 165.0 162.0 164.0 165.0 166.0 166.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:1.60 (2.1%) stddev-sans-first:1.66 11:35:38 INFO - PID 10897 | Values: 74.0 74.0 74.0 76.0 79.0 75.0 74.0 74.0 74.0 75.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:81.00 stddev:2.41 (3.0%) stddev-sans-first:2.18 11:35:38 INFO - PID 10897 | Values: 85.0 85.0 84.0 79.0 79.0 80.0 80.0 80.0 80.0 82.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.83 (1.6%) stddev-sans-first:1.83 11:35:38 INFO - PID 10897 | Values: 115.0 114.0 110.0 114.0 110.0 115.0 113.0 114.0 114.0 114.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.64 (1.1%) stddev-sans-first:1.73 11:35:38 INFO - PID 10897 | Values: 149.0 148.0 147.0 149.0 146.0 148.0 148.0 151.0 150.0 151.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.70 (1.8%) stddev-sans-first:1.01 11:35:38 INFO - PID 10897 | Values: 99.0 94.0 95.0 95.0 93.0 96.0 94.0 94.0 94.0 96.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.66 (3.1%) stddev-sans-first:1.00 11:35:38 INFO - PID 10897 | Values: 58.0 55.0 53.0 53.0 54.0 54.0 55.0 53.0 52.0 54.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:37.50 stddev:1.06 (2.8%) stddev-sans-first:1.09 11:35:38 INFO - PID 10897 | Values: 37.0 38.0 37.0 37.0 37.0 40.0 39.0 38.0 37.0 37.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:1.58 (2.1%) stddev-sans-first:1.67 11:35:38 INFO - PID 10897 | Values: 75.0 75.0 74.0 76.0 74.0 77.0 76.0 75.0 79.0 74.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:127.00 stddev:7.09 (5.6%) stddev-sans-first:7.52 11:35:38 INFO - PID 10897 | Values: 125.0 115.0 116.0 119.0 122.0 133.0 136.0 130.0 129.0 124.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:173.50 stddev:5.85 (3.4%) stddev-sans-first:5.87 11:35:38 INFO - PID 10897 | Values: 180.0 169.0 173.0 170.0 171.0 187.0 172.0 180.0 174.0 170.0 11:35:38 INFO - PID 10897 | 11:35:38 INFO - PID 10897 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:3.12 (4.7%) stddev-sans-first:3.21 11:35:38 INFO - PID 10897 | Values: 64.0 64.0 64.0 68.0 69.0 67.0 64.0 73.0 63.0 66.0 11:35:38 INFO - PID 10897 | -------- Summary: end -------- 11:35:38 INFO - PID 10897 | 11:35:39 INFO - PID 10897 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:35:39 INFO - TEST-INFO | 10897: exit 0 11:35:39 INFO - TEST-OK | kraken | took 61653ms 11:35:39 INFO - SUITE-END | took 1171s 11:35:39 INFO - Completed test suite (00:19:31) 11:35:39 INFO - javascript benchmark 11:35:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8399.491210946195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.861811218495, 3099.5195744659572, 3102.9689703102963, 3150.1809529522316, 3179.157523256339, 6195.2255968004, 6292.874142517158, 6382.4255816976465, 6407.455366293871, 6437.227532696077, 6269.028300613412, 6281.309056003836, 6386.0, 6442.355764423555, 6472.773452929148, 5838.657108864963, 5851.502622277111, 5887.4995625371785, 5924.674142922137, 5943.019401798698, 5846.824595262127, 5889.734961926723, 5903.35063143054, 6012.068129439944, 6034.969825150868, 5710.800121995731, 5749.568782341341, 5794.362620111805, 5803.883922321572, 5858.2677165354335, 5710.2576665033275, 5763.164341170549, 5789.015867302569, 5795.710214489259, 5892.469677729025, 5787.884242315172, 5794.188813566104, 5847.532197424196, 5858.443447872445, 5874.089516125007, 6183.1034499997695, 6263.874722505524, 6312.558120931537, 6375.075614035985, 6424.1327420798525, 6729.394354508069, 6856.588604683735, 6859.9314006859795, 6861.039454476378, 6868.862622747567, 6809.625470599115, 6834.179898412172, 6838.14523184602, 6895.896561551581, 6950.895736563955, 6283.371662833726, 6345.96827015862, 6347.39699728525, 6357.11000459936, 6358.078078678612, 6836.829079273058, 6922.723091076401, 6931.306869313028, 6971.442284617218, 6976.4767642426, 6579.934200658028, 6606.942889137715, 6631.171103612049, 6659.367360100783, 6668.199816022011, 6712.328767123248, 6715.227748808949, 6754.966225168842, 6812.352826481477, 6838.418734407532, 6711.127553418024, 6739.865202695919, 6781.559198652072, 6785.558938668971, 6787.966060169766, 6636.104125943032, 6693.698783554752, 6725.495587830835, 6743.797686069426, 6748.662566871735, 5302.204669299559, 5334.5732341412595, 5354.196870469461, 5365.839024829262, 5395.514403703685, 4644.326572646947, 4659.743714095689, 4686.554777296152, 4692.601128904013, 4725.220338644085, 5688.11834165705, 5762.020456522401, 5814.94185058144, 5877.4122587740885, 5886.440788125121, 6759.087523184406, 6807.693653785592, 6816.659167041727, 6823.55646882951, 6829.453643708492, 5748.827535173951, 5755.424457554211, 5756.827295181151, 5759.625624334405, 5764.769409223584, 5704.372519022904, 5721.828345149652, 5728.51307638847, 5794.565407594448, 5821.476067153976, 6072.483838873657, 6180.443760061616, 6382.648954307558, 6437.67811609427, 6515.641639709862, 6608.074869518367, 6662.16722909646, 6667.099941507834, 6699.497537684791, 6714.0600315954825, 6522.28254891971, 6567.605943643397, 6585.506087043395, 6651.0, 6653.767118150841, 6721.193456785217, 6762.695678694372, 6813.04617353561, 6836.350546698056, 6837.35045170708, 6768.052472653931, 6793.0, 6830.248672645906, 6874.381305682513, 6899.517033807585, 6375.808725738235, 6457.0637257596445, 6463.676816159267, 6470.158879345655, 6473.126127972663, 6404.583702059351, 6407.135036769976, 6431.453326467303, 6504.804855854332, 6534.9217379131915, 6530.8040758777315, 6534.215894092549, 6539.149910511603, 6545.2800191979795, 6594.8351291218105, 6623.4038936495945, 6646.8005959821285, 6649.2685804562425, 6694.895342268666, 6742.595444273359, 6222.28443728977, 6326.810195694136, 6381.106645069787, 6439.291677915519, 6474.935250647433], "value": 6156.578440959455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.2455351567379, 884.3279107878011, 885.8582626779717, 891.9152680495355, 898.0929261445938, 40841.3873791893, 41650.58349416505, 41797.58202417975, 41806.16387672252, 41900.58099419001, 37134.8143259284, 37339.813300933456, 37369.81315093428, 37371.252574948485, 37420.62579374205, 6987.30126987301, 7086.078809754725, 7089.113860767404, 7097.0, 7108.0048793169, 6956.65216739161, 7023.227444981048, 7024.367806897379, 7027.859442811141, 7029.367356937874, 7599.962000189991, 7839.333656639193, 7880.290773830354, 7882.172371900954, 7884.211578842099, 7639.388848892076, 7714.884276735854, 7783.922160778405, 7798.298153166185, 7801.765947021541, 7516.135644400909, 7660.885086723703, 7721.845563088763, 7737.381009519281, 7741.806454838674, 37179.4423083654, 37475.437868431996, 37490.43764343537, 37573.43639845405, 37592.248155036745, 3487.877924272638, 3547.9822600887087, 3550.8757193498104, 3551.271989242199, 3553.1650062235353, 30951.0, 31064.068077957698, 31084.533731994037, 31100.533491997638, 31171.220719481968, 5270.420253772082, 5276.657017293902, 5295.0, 5312.76092575835, 5327.38735045467, 174593.1270343653, 174939.0, 175549.0, 175697.99999999872, 176234.0, 41668.0, 42473.36289955653, 42643.36034959478, 49956.0, 50350.0, 51559.48440515547, 51860.22209666858, 51899.0, 51900.48099519032, 51936.0, 14002.43990240379, 14180.787288190686, 14185.78721319181, 14190.716185676436, 14262.57212283633, 10987.121030317556, 11133.610323638633, 11143.777124457627, 11172.720681983015, 11256.718582035515, 13700.588982330546, 13775.242361670204, 13957.860421395859, 14001.29993500321, 14070.437182512585, 5565.052231718866, 5600.355514722456, 5601.691906945157, 5695.515881150149, 5776.451237132465, 997.9251556133319, 1000.9949950250348, 1002.5839276700087, 1004.6634377483625, 1012.7492546704814, 22491.437714056952, 22523.774762252495, 22566.0, 22902.198423055448, 22959.0, 1089.0, 1094.8905109488987, 1100.8733995590449, 1104.282216559243, 1114.8662160540787, 11934.403279835973, 12088.75822483563, 12092.57675981354, 12302.938485307515, 12367.257964522158, 216887.0, 220026.0, 220574.0, 221092.0, 221479.0, 53867.73066134644, 54035.459645403826, 54308.45691543113, 54370.45629543733, 54413.45586544163, 1438.3167995202195, 1466.3254902744643, 1472.9263536823116, 1481.525911708243, 1490.0314795383088, 22403.32790016302, 22565.8871705647, 22711.659325110468, 22844.200452984067, 22855.0, 38207.808960955015, 38218.42672359861, 38227.42658860064, 38253.0, 38300.80849595734, 186563.0, 186734.0, 187060.0, 187380.0, 188059.0597047006, 30351.544726828673, 30857.8457107722, 34789.82605086958, 35058.123546911535, 35091.29817403587, 43767.78116109399, 43978.34032489451, 44030.55969440265, 44056.0, 44256.336154957055, 31496.842515787273, 31779.36441271208, 31886.84056579702, 31985.36029279355, 32480.512792308607, 31645.841770790998, 31647.36705265928, 31701.20746981344, 31708.0, 31713.0, 35526.0, 36364.63635363719, 36452.63547364598, 36694.0, 36934.44598331081, 30817.229569260948, 31190.532142017433, 31359.0, 31883.68116318807, 32478.350432990734, 22933.426664333525, 23108.768912311334, 23309.41726456852, 23732.644010340206, 23859.164929227394], "value": 16774.01840348007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.556822894028, 565.5701666733281, 566.7534622439237, 585.8213244960288, 600.7867207141464, 21737.456563585918, 22249.2212772553, 22371.888140559317, 22393.0, 22411.0, 21739.456513587167, 22031.559368812614, 22214.11143554256, 24515.509689806193, 24879.253622391312, 6355.0, 6397.6801159941815, 6410.102585638015, 6418.903716444257, 6480.092787009822, 6149.815505534841, 6310.621362718229, 6405.42351188393, 6410.871782564346, 6413.583117097397, 6346.682665866688, 6378.521610879179, 6382.808515744535, 6396.424321811036, 6408.0, 6384.170057892491, 6394.040893865911, 6403.679816009181, 6406.551541392105, 6409.294977552466, 5910.290765108214, 5935.643861368331, 5936.7328470218945, 5941.851453713649, 5957.642541447483, 26682.0, 27457.17628471129, 27968.720312796817, 28025.159245222676, 28230.15309540717, 2038.3579172560596, 2082.333653230967, 2084.0205103601284, 2093.1418118571464, 2094.2356040045424, 18667.813321866743, 19295.324663636704, 19321.51696207606, 19348.903255483772, 19362.322318718776, 2347.6713260143592, 2367.30164601443, 2408.5303365843665, 2412.867292298923, 2415.058127330325, 107298.46350768274, 111782.44108779404, 123455.0, 129878.99999999905, 133681.0, 14015.649608759863, 14313.427462901367, 14331.498397556035, 14494.202818845064, 14501.927490362481, 22138.88930555337, 22224.88887555552, 22340.0, 22341.888290558443, 22405.32784016482, 9604.711858644252, 9964.750881227883, 9973.351732137387, 10030.191546367028, 10106.797864042825, 9418.0, 9465.432074075577, 9471.289653276031, 9517.714468565953, 9595.23238140947, 8677.869831952527, 8753.824923501494, 8811.955940220258, 8933.642654293886, 9025.864612030824, 2650.271175426773, 2659.4415172813924, 2687.9462410751676, 2757.903473378422, 2816.4226333601564, 969.8981606931312, 974.449436068619, 982.7543114221445, 992.3004281981185, 1011.7369483934083, 18491.260349586137, 18713.90643046776, 18748.625027499373, 18844.623107537773, 19187.520311992314, 1017.4404077757204, 1029.9176065914858, 1035.6478797208986, 1035.9792804143874, 1045.8222102242637, 10514.421706806199, 10523.368597884151, 10587.682369528773, 10590.682279531626, 10983.780324393627, 409598.0, 420751.0, 426894.0, 431460.0, 435180.0, 103017.0, 104385.95614043763, 104525.47737261264, 107910.46044769726, 109714.45142774234, 1144.5879483385975, 1155.7399585093456, 1168.3457263932225, 1236.975260494785, 1241.3793103448277, 19890.0, 19950.700739488628, 20361.0, 20459.693104603146, 20503.79496205019, 53717.92564148773, 54353.0, 55073.44926550683, 55662.886742265735, 56584.43415565956, 67127.3287267121, 67397.0, 67430.66284668545, 67820.32179678338, 67999.66000169968, 13598.456061757815, 14008.579742607739, 14089.084209526349, 14102.083364581269, 14123.364448599632, 21827.126914923225, 22003.0, 22150.446238844157, 22173.556528869656, 22222.111115555195, 17516.82483175152, 17723.645527089127, 17867.374641887473, 18019.639607208046, 18025.2789888403, 14849.886258530438, 16245.837541624905, 16415.26131324117, 16659.416920407726, 16929.407470738464, 16202.756958645865, 17436.82563174352, 17984.10079496046, 17989.64020719552, 18223.45329640113, 13920.651983700489, 13963.720725585634, 14004.719905601627, 14024.368903399576, 14082.859171408565, 17085.145742712564, 17218.655626887143, 17594.38419655306, 17731.468055958343, 17812.732809007615], "value": 11606.800541824812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.1346338343458, 1398.6573289544058, 1415.7805540141283, 1417.3621870158431, 1427.5146450206928, 15011.849881501183, 15680.451184208556, 15686.764698529518, 15699.0, 15701.450449234278, 15220.162891040989, 15352.0, 15352.769708454382, 15364.6927061459, 15365.923170384132, 2718.864056797157, 2788.888444462229, 2796.3149028487946, 2796.4407118576364, 2801.9859900700467, 2722.9863850680717, 2796.8601569921525, 2801.3276813564803, 2809.101087651952, 2810.12886005339, 2654.986725066372, 2749.2714430675887, 2850.558163484663, 2852.215640698804, 2853.957190642142, 2797.776177905783, 2813.22636275024, 2818.591304260871, 2824.844633545154, 2841.403305305878, 2624.7375262473793, 2791.2184588315304, 2794.315392728774, 2798.4822807780624, 2799.1042866282796, 15143.924280378527, 15221.695566088616, 15234.162121083336, 15236.923815380964, 15249.466268680542, 7975.641096150687, 8246.876296855551, 8258.8348233035, 8259.297959673375, 8261.876071858927, 5389.649672771257, 5467.644603100785, 5528.530074943635, 5597.216389705444, 5607.102863541813, 1844.124041080476, 1845.243450185431, 1860.2094110003195, 1912.6557219700449, 1913.0912816412233, 25972.87013564939, 26176.34559136037, 26258.0, 27466.17601471959, 27484.312892177655, 6913.170419549686, 6918.446524278046, 6940.09778728762, 7112.395446387115, 7172.0676312079095, 17240.65518689619, 17247.65504689899, 17284.913575432292, 17306.307747690204, 17308.65382692339, 7526.849463010819, 7553.055868016498, 7558.773236802905, 7561.697532098655, 7562.054743157106, 6823.658817059128, 6889.793306200822, 6938.548994315353, 6963.512554121265, 6988.091548098816, 4963.553280204726, 5108.386993560722, 5125.384953805567, 5135.229715542624, 5155.7679904404395, 1372.4647387518876, 1376.6440056544295, 1380.2063813307389, 1389.4928351151757, 1396.553103007028, 883.7746374674546, 898.5552151684958, 903.3947255338938, 906.2478143141177, 913.0641092879852, 7360.77917662471, 7445.813854653677, 7493.100827900686, 7528.134264559536, 7609.239076092346, 722.7000794670153, 729.1578227147653, 729.711763853275, 737.4837613670452, 746.8468963862396, 4917.237828136645, 5073.746312684351, 5107.974460127675, 5205.427402985669, 5290.047791397508, 21445.249416270668, 21864.89067554652, 22272.888635557043, 22343.32970010902, 22360.776392236196, 20886.0, 21940.122395104336, 21989.780102199093, 22121.0, 22170.44573885666, 9297.209737172281, 9629.229661627052, 10774.461276935965, 10916.399598022184, 11073.0, 8995.595198215966, 9000.964889037845, 9052.547372631474, 9097.909020909707, 9119.589618467318, 17861.196246168693, 18503.167357469214, 18609.720854186926, 18755.156017978952, 18778.624427511648, 18578.163982621085, 18854.434366969013, 18968.620627587647, 19061.714074289175, 19219.711704324727, 10695.518701658288, 10795.73010674708, 10875.347479151276, 10889.401082940514, 10901.618443354444, 13673.589792306248, 13683.315834208448, 13795.241261730702, 13814.240216787772, 13819.723605527632, 11269.549218031514, 11505.194636375374, 11516.251443656136, 11637.5344986203, 11665.59170429065, 10691.786164276826, 10698.518566664363, 10712.785744284914, 10748.301360411548, 10997.725056873322, 10002.0, 10267.537960791931, 10273.897261027592, 10278.074973252444, 10283.537240824031, 6853.828654283483, 6854.794356169323, 6910.896336555056, 6926.965365173141, 6961.269066747918, 7195.892061618975, 7273.8908916365235, 7301.598412087386, 7375.594342311009, 7405.7778266652085], "value": 6606.971521154449, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.251093226418, 498.7458010004253, 516.1560848013497, 516.643515973978, 526.6945171800356, 6210.347913469082, 6345.270293916195, 6376.866622368992, 6421.67891605419, 6430.810300094486, 6175.444210021097, 6186.7525298987985, 6204.0, 6213.502919766419, 6258.561900666955, 4864.659473836833, 4960.553550180483, 4975.701457912528, 4990.053878987198, 5019.874503137433, 5001.974990125044, 5070.645054846163, 5094.872628184306, 5121.385433747955, 5123.4108077571, 4960.2559616057515, 4973.776180071887, 5002.349694539705, 5035.899282014358, 5042.369703787027, 4943.6539442239055, 4964.776585053663, 4994.700317980933, 5001.199808030698, 5029.295898574166, 4475.239209334389, 4483.49802816057, 4484.865454036384, 4496.168208881335, 4530.252508336121, 6100.96949515254, 6219.937800621981, 6268.717907694165, 6288.402601752826, 6299.0, 5648.8870222595315, 5682.232898558683, 5692.715364231772, 5702.800401985911, 5710.0, 6498.5126115541525, 6502.902456463157, 6538.346165383471, 6569.981652843817, 6666.566673166229, 4872.634552408548, 4898.118338699032, 4901.485344038896, 4903.896623259774, 4911.312416261726, 6758.0, 6844.931550684529, 6846.554973926679, 6848.417884479825, 7033.331833475862, 4944.085344211332, 4967.950320496749, 4992.925106123411, 5044.0, 5061.746912654353, 5070.340855688811, 5080.288759573663, 5089.9745501273, 5093.719845408538, 5122.1804511278015, 5627.971860140755, 5649.435056494318, 5681.375048744635, 5689.231953686282, 5724.055530837449, 6333.778317758856, 6357.936420635827, 6572.80281591553, 6594.571352862049, 6637.269900310962, 1732.9133543322782, 1737.3311275159156, 1750.1074452029302, 1753.8509226715616, 1768.7789026371704, 1202.482932339085, 1208.2871106047473, 1218.7257866979858, 1220.7924652809045, 1223.8837310455492, 5673.943260567424, 5739.49449682006, 5743.0, 5812.837432513515, 5842.474177324061, 6900.896486552706, 6912.516123871382, 6917.169939607279, 6928.549644273106, 6953.269906659829, 5832.766689332379, 5834.708264586839, 5841.50347220491, 5863.442972917566, 5880.941190588125, 3606.314800187956, 3621.8913432597064, 3650.324689932371, 3675.1363429594026, 3691.6308369163407, 6508.576942498722, 6603.151117687055, 6620.86758264832, 6629.668516574152, 6653.334666533405, 6903.965480172667, 6941.34057264559, 6946.714857751333, 7044.22513523512, 7076.32774886385, 6558.639274839834, 6566.6388348641285, 6573.3098024706715, 6606.669666516655, 6636.236832764197, 6838.863222735617, 6848.794536163923, 6924.58452492852, 6944.687489062903, 6977.755778547727, 6750.291219422086, 6804.4216241620015, 6817.136802542845, 6831.555948863308, 6878.8624227516175, 6621.404073633396, 6647.135872336566, 6669.7665581704405, 6670.599764014175, 6706.731730730911, 4948.35671362735, 4956.3804524434445, 4982.377202849644, 5007.899842003212, 5041.218611115283, 6586.637734924625, 6801.727930882709, 6855.503693116447, 6882.655867206719, 6950.860982780215, 6384.233891932998, 6573.112629794917, 6574.901376479261, 6586.967065164644, 6600.735970561316, 6483.481321494363, 6520.152380190734, 6555.2789193187755, 6572.309907459648, 6611.305812889577, 6415.647139407378, 6451.387118223761, 6470.352964703492, 6507.0, 6540.967295163494, 6559.376859198369, 6600.471962242913, 6632.303608121078, 6633.170853643294, 6654.800355989328, 6313.842153946188, 6345.365463453618, 6368.630744389979, 6425.453836423956, 6427.614343139239], "value": 5095.588878051831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.4597142899972, 841.0286119531941, 892.7187935800223, 905.3074398085462, 933.7012156110043, 19357.903210483946, 20343.287984920513, 20357.389278321654, 20364.08361623727, 20397.796022039776, 17942.641147177048, 18218.362357317495, 18352.81647183528, 19199.808001919977, 19240.807591924076, 911.0252030327536, 936.4802534593298, 939.8825146856609, 943.8820147481565, 944.1832814615377, 956.115593076405, 994.7910938702881, 998.181491177235, 1001.8397056470966, 1002.1832206751474, 1036.3367444835312, 1042.2547878267037, 1046.4610725476387, 1047.5914393386586, 1048.088163297928, 1030.1141018723893, 1030.6907927621683, 1032.0247366238907, 1032.210359075308, 1032.2258306270335, 722.1370462297557, 743.605888878895, 750.6922161913644, 751.6730222353294, 765.3571000359725, 20165.596688066304, 20370.388888333375, 20372.490687732778, 20399.592008159754, 20419.2853250137, 21178.152873885025, 21367.0, 21822.0, 21909.0, 21931.890340548354, 17455.21451534684, 17589.912050439794, 17684.823151768447, 18030.0, 18070.457886263433, 3636.7454278200535, 3662.285854258421, 3664.992127165024, 3672.247189326182, 3673.5040769496045, 141936.0, 142838.57161428357, 143861.2806935969, 145186.0, 148017.0, 16076.839231607533, 16615.08617026051, 16731.0, 16774.49676509707, 16809.49571512832, 30877.382452350826, 30932.22669433282, 31776.36447271088, 31889.840550797562, 31946.0, 8106.83786324282, 8282.088970213272, 8283.0, 8289.839422480858, 8291.917080829115, 3904.7266691331333, 4234.280172370704, 4292.248856450109, 4326.58897404746, 4331.371951067078, 5114.3862736471865, 5226.477352264743, 5240.528352448298, 5245.318108645852, 5249.973750131225, 921.1939552891221, 948.037741692183, 956.3353469338882, 958.6261358070358, 960.8318544254728, 585.771549095853, 587.3891153200624, 597.2206270816539, 598.335847209597, 628.4563852267755, 11268.718282043015, 11414.828777568344, 11640.708982275512, 12180.878191218151, 12260.570880019335, 669.9397054265042, 677.847484316025, 678.8099332186996, 694.9200841903145, 698.5389642835704, 5192.169252919514, 5295.443978382292, 5302.3637163540625, 5349.010433069894, 5355.651882627617, 125638.0, 128734.0, 128860.65700763257, 130935.34532327278, 133518.0, 106358.0, 106709.0, 107166.46416768023, 107859.0, 108077.45961270301, 92218.0778192223, 94221.0, 97482.0, 100263.49868250612, 100468.99062018719, 9719.611215551582, 9946.104850563484, 9996.550155243178, 10017.14854237398, 10028.29801913859, 41884.37173442462, 43066.354004689325, 43284.0, 43374.34938475862, 43672.12655746804, 56443.0, 56676.716616416656, 57113.0, 57391.42608573861, 58286.708566456895, 14635.195064271142, 14902.403903843724, 14998.0, 15151.469698560497, 15155.0, 16616.00303981765, 16698.165091745606, 16896.66206675835, 17007.659846803243, 17057.0, 15261.23693815327, 15420.84579154194, 15464.072155670696, 15542.766858496905, 15566.0, 14139.64650883736, 14173.929130354281, 14312.212828294543, 14423.278836058365, 14433.0, 11287.774244515227, 13988.440462381392, 14473.782893256399, 14494.275286235857, 14496.637584060483, 9893.159081478156, 10247.7438064049, 10395.168386528909, 10638.73403164927, 10750.516226769658, 10614.840777388192, 10739.248252622241, 10922.12622990143, 10998.230123891251, 11091.389973551532], "value": 8701.768489796117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 108.0, 108.0, 107.0, 109.0, 101.0, 110.0, 108.0, 108.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 115.0, 119.0, 116.0, 131.0, 120.0, 116.0, 142.0, 123.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 162.0, 165.0, 162.0, 164.0, 165.0, 166.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 76.0, 79.0, 75.0, 74.0, 74.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 82.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 110.0, 114.0, 110.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 146.0, 148.0, 148.0, 151.0, 150.0, 151.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 95.0, 93.0, 96.0, 94.0, 94.0, 94.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 53.0, 53.0, 54.0, 54.0, 55.0, 53.0, 52.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 37.0, 40.0, 39.0, 38.0, 37.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 74.0, 77.0, 76.0, 75.0, 79.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 115.0, 116.0, 119.0, 122.0, 133.0, 136.0, 130.0, 129.0, 124.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 169.0, 173.0, 170.0, 171.0, 187.0, 172.0, 180.0, 174.0, 170.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 68.0, 69.0, 67.0, 64.0, 73.0, 63.0, 66.0], "value": 66.2, "unit": "score"}]}]} 11:35:39 INFO - Return code: 0 11:35:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:35:40 INFO - # TBPL SUCCESS # 11:35:40 INFO - Running post-action listener: _package_coverage_data 11:35:40 INFO - Running post-action listener: _resource_record_post_action 11:35:40 INFO - [mozharness: 2017-09-09 18:35:40.001031Z] Finished run-tests step (success) 11:35:40 INFO - Running post-run listener: _resource_record_post_run 11:35:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305451008; Read time: 8; Write time: 170180 11:35:40 INFO - TinderboxPrint: CPU usage
13.1% 11:35:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:35:40 INFO - TinderboxPrint: I/O write bytes / time
305,451,008 / 170,180 11:35:40 INFO - TinderboxPrint: CPU idle
8,236.0 (86.9%) 11:35:40 INFO - TinderboxPrint: CPU user
1,192.6 (12.6%) 11:35:40 INFO - TinderboxPrint: Swap in / out
0 / 0 11:35:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 12554240; Read time: 0; Write time: 2204 11:35:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:35:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292896768; Read time: 8; Write time: 167976 11:35:40 INFO - Running post-run listener: _upload_blobber_files 11:35:40 INFO - Blob upload gear active. 11:35:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:40 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 11:35:40 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:35:40 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:42 INFO - (blobuploader) - INFO - Done attempting. 11:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:42 INFO - (blobuploader) - INFO - Done attempting. 11:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:49 INFO - (blobuploader) - INFO - Done attempting. 11:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:50 INFO - (blobuploader) - INFO - Done attempting. 11:35:50 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:50 INFO - Return code: 0 11:35:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b84a697f797185d5e1912bad7170f138d234551d73db1613250443f60d3ea6924e6251a9e3bf01e95314377d22ff9091568b7ccebda083509b66e0d146e8c472", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b073f6d47c441e09c3225f8c33a0377b7ad659e57a82cdd434318d7980ee0afcfcddde84bb3f2e0077ac6dd265ced8366ba68e29eb8ddd65c40fa875fc45991", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34e117c625c8886e8967641a58704262509fe3b2e284f7b17d1041d91bb48921e781c780e36c2b82a217988b5cf6b0b5a5460015b5526c261aaeb16ffc9383", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59741aca043726b149dba3316a8b8d1aff320cb6d4d0dd81c4553e2108e757d194cff047897edf61827a1f7a31500326dee8c5b7039807f4dbb5c702add2d37f"} 11:35:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:50 INFO - Contents: 11:35:50 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b84a697f797185d5e1912bad7170f138d234551d73db1613250443f60d3ea6924e6251a9e3bf01e95314377d22ff9091568b7ccebda083509b66e0d146e8c472", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b073f6d47c441e09c3225f8c33a0377b7ad659e57a82cdd434318d7980ee0afcfcddde84bb3f2e0077ac6dd265ced8366ba68e29eb8ddd65c40fa875fc45991", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34e117c625c8886e8967641a58704262509fe3b2e284f7b17d1041d91bb48921e781c780e36c2b82a217988b5cf6b0b5a5460015b5526c261aaeb16ffc9383", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59741aca043726b149dba3316a8b8d1aff320cb6d4d0dd81c4553e2108e757d194cff047897edf61827a1f7a31500326dee8c5b7039807f4dbb5c702add2d37f"} 11:35:50 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:50 INFO - Copying logs to upload dir... 11:35:50 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.818024 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-09 11:35:50.731940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 11:35:50.735533) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 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-Non-PGO/sha512/b84a697f797185d5e1912bad7170f138d234551d73db1613250443f60d3ea6924e6251a9e3bf01e95314377d22ff9091568b7ccebda083509b66e0d146e8c472", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b073f6d47c441e09c3225f8c33a0377b7ad659e57a82cdd434318d7980ee0afcfcddde84bb3f2e0077ac6dd265ced8366ba68e29eb8ddd65c40fa875fc45991", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34e117c625c8886e8967641a58704262509fe3b2e284f7b17d1041d91bb48921e781c780e36c2b82a217988b5cf6b0b5a5460015b5526c261aaeb16ffc9383", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59741aca043726b149dba3316a8b8d1aff320cb6d4d0dd81c4553e2108e757d194cff047897edf61827a1f7a31500326dee8c5b7039807f4dbb5c702add2d37f"} build_url:https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b84a697f797185d5e1912bad7170f138d234551d73db1613250443f60d3ea6924e6251a9e3bf01e95314377d22ff9091568b7ccebda083509b66e0d146e8c472", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b073f6d47c441e09c3225f8c33a0377b7ad659e57a82cdd434318d7980ee0afcfcddde84bb3f2e0077ac6dd265ced8366ba68e29eb8ddd65c40fa875fc45991", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f34e117c625c8886e8967641a58704262509fe3b2e284f7b17d1041d91bb48921e781c780e36c2b82a217988b5cf6b0b5a5460015b5526c261aaeb16ffc9383", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59741aca043726b149dba3316a8b8d1aff320cb6d4d0dd81c4553e2108e757d194cff047897edf61827a1f7a31500326dee8c5b7039807f4dbb5c702add2d37f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 11:35:50.765295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:35:50.765669) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1504980910.397767-2076814623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:35:50.848325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 11:35:50.848708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 11:35:50.849057) ========= ========= Total master_lag: 0.20 =========