builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1501199727.29 results: success (0) revision: a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.291058) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.291464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.291742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.320329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.320610) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 16:55:27-- 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% 42.5M=0s 2017-07-27 16:55:27 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141814 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.509355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.509685) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.556177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:27.556507) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c --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 a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c --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=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 16:55:27,920 truncating revision to first 12 chars 2017-07-27 16:55:27,920 Setting DEBUG logging. 2017-07-27 16:55:27,920 attempt 1/10 2017-07-27 16:55:27,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4afa89bfdd1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 16:55:28,298 unpacking tar archive at: mozilla-central-a4afa89bfdd1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:28.473691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:28.474011) ========= script_repo_revision: a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:28.474395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:28.474667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:55:28.488022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 16:55:28.488318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:28 INFO - MultiFileLogger online at 20170727 16:55:28 in /builds/slave/test 16:55:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:28 INFO - {'append_to_log': False, 16:55:28 INFO - 'base_work_dir': '/builds/slave/test', 16:55:28 INFO - 'blob_upload_branch': 'Firefox', 16:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:28 INFO - 'branch': 'Firefox', 16:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:28 INFO - 'code_coverage': False, 16:55:28 INFO - 'config_files': ('talos/linux_config.py',), 16:55:28 INFO - 'default_actions': ('clobber', 16:55:28 INFO - 'read-buildbot-config', 16:55:28 INFO - 'download-and-extract', 16:55:28 INFO - 'populate-webroot', 16:55:28 INFO - 'create-virtualenv', 16:55:28 INFO - 'install', 16:55:28 INFO - 'setup-mitmproxy', 16:55:28 INFO - 'run-tests'), 16:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:28 INFO - 'disable_ccov_upload': False, 16:55:28 INFO - 'download_minidump_stackwalk': True, 16:55:28 INFO - 'download_symbols': 'ondemand', 16:55:28 INFO - 'enable_stylo': False, 16:55:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:55:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:55:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:55:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:28 INFO - 'gecko_profile': False, 16:55:28 INFO - 'gecko_profile_interval': 0, 16:55:28 INFO - 'installer_path': 'installer.exe', 16:55:28 INFO - 'log_level': 'info', 16:55:28 INFO - 'log_name': 'talos', 16:55:28 INFO - 'log_to_console': True, 16:55:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:28 INFO - 'opt_config_files': (), 16:55:28 INFO - 'pip_index': False, 16:55:28 INFO - 'suite': 'dromaeojs-e10s', 16:55:28 INFO - 'system_bits': '32', 16:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:28 INFO - 'title': 'talos-linux64-ix-088', 16:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:28 INFO - 'use_talos_json': True, 16:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:28 INFO - 'work_dir': 'build'} 16:55:28 INFO - [mozharness: 2017-07-27 23:55:28.946571Z] Running clobber step. 16:55:28 INFO - Running pre-action listener: _resource_record_pre_action 16:55:28 INFO - Running main action method: clobber 16:55:28 INFO - rmtree: /builds/slave/test/build 16:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:29 INFO - Running post-action listener: _resource_record_post_action 16:55:29 INFO - [mozharness: 2017-07-27 23:55:29.995259Z] Finished clobber step (success) 16:55:29 INFO - [mozharness: 2017-07-27 23:55:29.995362Z] Running read-buildbot-config step. 16:55:29 INFO - Running pre-action listener: _resource_record_pre_action 16:55:29 INFO - Running main action method: read_buildbot_config 16:55:29 INFO - Using buildbot properties: 16:55:29 INFO - { 16:55:29 INFO - "project": "", 16:55:29 INFO - "product": "firefox", 16:55:29 INFO - "who": "kwierso@gmail.com", 16:55:29 INFO - "installer_path": "public/build/target.tar.bz2", 16:55:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:55:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:55:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:55:29 INFO - "stage_platform": "linux64-stylosequential", 16:55:29 INFO - "basedir": "/builds/slave/test", 16:55:29 INFO - "buildnumber": 125, 16:55:29 INFO - "platform": "ubuntu64_hw_styloseq", 16:55:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:29 INFO - "slavebuilddir": "test", 16:55:29 INFO - "taskId": "WJAkbZMjQe2jPLl6Y01w4A", 16:55:29 INFO - "branch": "mozilla-central", 16:55:29 INFO - "script_repo_revision": "production", 16:55:29 INFO - "revision": "a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c", 16:55:29 INFO - "slavename": "talos-linux64-ix-088", 16:55:29 INFO - "repo_path": "mozilla-central" 16:55:29 INFO - } 16:55:29 INFO - Finding installer, test and symbols from parent task. 16:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJAkbZMjQe2jPLl6Y01w4A'}, attempt #1 16:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJAkbZMjQe2jPLl6Y01w4A'}, attempt #1 16:55:30 INFO - Task dependencies: M4-l_DlIR0urDflX_RShmA 16:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA'}, attempt #1 16:55:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 16:55:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/test_packages.json 16:55:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.crashreporter-symbols.zip 16:55:31 INFO - Running post-action listener: _resource_record_post_action 16:55:31 INFO - [mozharness: 2017-07-27 23:55:31.324052Z] Finished read-buildbot-config step (success) 16:55:31 INFO - [mozharness: 2017-07-27 23:55:31.324275Z] Running download-and-extract step. 16:55:31 INFO - Running pre-action listener: _resource_record_pre_action 16:55:31 INFO - Running main action method: download_and_extract 16:55:31 INFO - mkdir: /builds/slave/test/build/tests 16:55: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')]} 16:55:31 INFO - trying https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.test_packages.json 16:55:31 INFO - Downloading https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:31 INFO - Downloaded 989 bytes. 16:55:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:31 INFO - Using the following test package requirements: 16:55:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:31 INFO - u'common': [u'target.common.tests.zip'], 16:55:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:31 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:31 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:31 INFO - u'target.web-platform.tests.tar.gz'], 16:55:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:55:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip 16:55:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:31 INFO - Fetch https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip into memory 16:55:33 INFO - Content-Length response header: 72561184 16:55:33 INFO - Bytes received: 72561184 16:55:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip 16:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.common.tests.zip into memory 16:55:45 INFO - Content-Length response header: 72561184 16:55:45 INFO - Bytes received: 72561184 16:55:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.talos.tests.zip 16:55:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:58 INFO - Fetch https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.talos.tests.zip into memory 16:55:58 INFO - Content-Length response header: 14496465 16:55:58 INFO - Bytes received: 14496465 16:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:59 INFO - trying https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 16:55:59 INFO - Downloading https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:56:00 INFO - Downloaded 62184176 bytes. 16:56:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 16:56:00 INFO - mkdir: /builds/slave/test/properties 16:56:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:00 INFO - Contents: 16:56:00 INFO - build_url:https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 16:56:00 INFO - Running post-action listener: _resource_record_post_action 16:56:00 INFO - Running post-action listener: set_extra_try_arguments 16:56:00 INFO - [mozharness: 2017-07-27 23:56:00.215691Z] Finished download-and-extract step (success) 16:56:00 INFO - [mozharness: 2017-07-27 23:56:00.215834Z] Running populate-webroot step. 16:56:00 INFO - Running pre-action listener: _resource_record_pre_action 16:56:00 INFO - Running main action method: populate_webroot 16:56:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:56:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:56:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:56:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:56:00 INFO - 'tests': ['damp', 'tps']}, 16:56:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:56:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:56:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:56:00 INFO - 'other-e10s': {'tests': ['a11yr', 16:56:00 INFO - 'ts_paint', 16:56:00 INFO - 'tpaint', 16:56:00 INFO - 'sessionrestore', 16:56:00 INFO - 'sessionrestore_many_windows', 16:56:00 INFO - 'sessionrestore_no_auto_restore', 16:56:00 INFO - 'tabpaint']}, 16:56:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:56:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:56:00 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:56:00 INFO - 'talos_options': ['--mitmproxy', 16:56:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:56:00 INFO - '--firstNonBlankPaint'], 16:56:00 INFO - 'tests': ['quantum_pageload_google', 16:56:00 INFO - 'quantum_pageload_youtube', 16:56:00 INFO - 'quantum_pageload_amazon', 16:56:00 INFO - 'quantum_pageload_facebook']}, 16:56:00 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:56:00 INFO - 'talos_options': ['--stylo', 16:56:00 INFO - '--mitmproxy', 16:56:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:56:00 INFO - '--firstNonBlankPaint'], 16:56:00 INFO - 'tests': ['quantum_pageload_google', 16:56:00 INFO - 'quantum_pageload_youtube', 16:56:00 INFO - 'quantum_pageload_amazon', 16:56:00 INFO - 'quantum_pageload_facebook']}, 16:56:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:56:00 INFO - 'tsvgr_opacity', 16:56:00 INFO - 'tart', 16:56:00 INFO - 'tscrollx', 16:56:00 INFO - 'cart', 16:56:00 INFO - 'tsvg_static']}, 16:56:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:56:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:56:00 INFO - 'talos_options': ['--xperf_path', 16:56:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:00 INFO - 'tests': ['tp5n']}}} 16:56:00 INFO - Running post-action listener: _resource_record_post_action 16:56:00 INFO - [mozharness: 2017-07-27 23:56:00.226546Z] Finished populate-webroot step (success) 16:56:00 INFO - [mozharness: 2017-07-27 23:56:00.226636Z] Running create-virtualenv step. 16:56:00 INFO - Running pre-action listener: _resource_record_pre_action 16:56:00 INFO - Running main action method: create_virtualenv 16:56:00 INFO - Creating virtualenv /builds/slave/test/build/venv 16:56:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:56:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:56:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:56:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:00 INFO - Using real prefix '/usr' 16:56:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:56:00 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:02 INFO - Installing pip.................done. 16:56:02 INFO - Return code: 0 16:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:56:02 INFO - Reading from file tmpfile_stdout 16:56:02 INFO - Output received: 16:56:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:56:02 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')]} 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:02 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')]} 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:03 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:03 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 16:56:03 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 16:56:03 INFO - Using env: {'DISPLAY': ':0', 16:56:03 INFO - 'HOME': '/home/cltbld', 16:56:03 INFO - 'LANG': 'en_US.UTF-8', 16:56:03 INFO - 'LANGUAGE': 'en_US:en', 16:56:03 INFO - 'LOGNAME': 'cltbld', 16:56:03 INFO - 'MAIL': '/var/mail/cltbld', 16:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:03 INFO - 'MOZ_NO_REMOTE': '1', 16:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:03 INFO - 'NO_EM_RESTART': '1', 16:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:03 INFO - 'PWD': '/builds/slave/test', 16:56:03 INFO - 'SHELL': '/bin/bash', 16:56:03 INFO - 'SHLVL': '1', 16:56:03 INFO - 'TERM': 'linux', 16:56:03 INFO - 'TMOUT': '86400', 16:56:03 INFO - 'USER': 'cltbld', 16:56:03 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:03 INFO - '_': '/tools/buildbot/bin/python'} 16:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:56:03 INFO - Cleaning up... 16:56:03 INFO - Return code: 0 16:56:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:03 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:03 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 16:56:03 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 16:56:03 INFO - Using env: {'DISPLAY': ':0', 16:56:03 INFO - 'HOME': '/home/cltbld', 16:56:03 INFO - 'LANG': 'en_US.UTF-8', 16:56:03 INFO - 'LANGUAGE': 'en_US:en', 16:56:03 INFO - 'LOGNAME': 'cltbld', 16:56:03 INFO - 'MAIL': '/var/mail/cltbld', 16:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:03 INFO - 'MOZ_NO_REMOTE': '1', 16:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:03 INFO - 'NO_EM_RESTART': '1', 16:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:03 INFO - 'PWD': '/builds/slave/test', 16:56:03 INFO - 'SHELL': '/bin/bash', 16:56:03 INFO - 'SHLVL': '1', 16:56:03 INFO - 'TERM': 'linux', 16:56:03 INFO - 'TMOUT': '86400', 16:56:03 INFO - 'USER': 'cltbld', 16:56:03 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:03 INFO - '_': '/tools/buildbot/bin/python'} 16:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:03 INFO - Downloading/unpacking psutil>=3.1.1 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:04 INFO - Installing collected packages: psutil 16:56:04 INFO - Running setup.py install for psutil 16:56:04 INFO - building 'psutil._psutil_linux' extension 16:56:04 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 16:56:04 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 16:56:04 INFO - building 'psutil._psutil_posix' extension 16:56:04 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 16:56:05 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 16:56:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:05 INFO - Successfully installed psutil 16:56:05 INFO - Cleaning up... 16:56:05 INFO - Return code: 0 16:56:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:56:05 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')]} 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:05 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')]} 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:05 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:05 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 16:56:05 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 16:56:05 INFO - Using env: {'DISPLAY': ':0', 16:56:05 INFO - 'HOME': '/home/cltbld', 16:56:05 INFO - 'LANG': 'en_US.UTF-8', 16:56:05 INFO - 'LANGUAGE': 'en_US:en', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MAIL': '/var/mail/cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SHLVL': '1', 16:56:05 INFO - 'TERM': 'linux', 16:56:05 INFO - 'TMOUT': '86400', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - '_': '/tools/buildbot/bin/python'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:06 INFO - Installing collected packages: mozsystemmonitor 16:56:06 INFO - Running setup.py install for mozsystemmonitor 16:56:06 INFO - Successfully installed mozsystemmonitor 16:56:06 INFO - Cleaning up... 16:56:06 INFO - Return code: 0 16:56:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:06 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:06 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 16:56:06 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 16:56:06 INFO - Using env: {'DISPLAY': ':0', 16:56:06 INFO - 'HOME': '/home/cltbld', 16:56:06 INFO - 'LANG': 'en_US.UTF-8', 16:56:06 INFO - 'LANGUAGE': 'en_US:en', 16:56:06 INFO - 'LOGNAME': 'cltbld', 16:56:06 INFO - 'MAIL': '/var/mail/cltbld', 16:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:06 INFO - 'MOZ_NO_REMOTE': '1', 16:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:06 INFO - 'NO_EM_RESTART': '1', 16:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:06 INFO - 'PWD': '/builds/slave/test', 16:56:06 INFO - 'SHELL': '/bin/bash', 16:56:06 INFO - 'SHLVL': '1', 16:56:06 INFO - 'TERM': 'linux', 16:56:06 INFO - 'TMOUT': '86400', 16:56:06 INFO - 'USER': 'cltbld', 16:56:06 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:06 INFO - '_': '/tools/buildbot/bin/python'} 16:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:06 INFO - Downloading/unpacking jsonschema==2.5.1 16:56:06 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 16:56:06 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 16:56:06 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 16:56:06 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 16:56:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:08 INFO - warning: no files found matching '*.txt' 16:56:08 INFO - no previously-included directories found matching 'build' 16:56:08 INFO - no previously-included directories found matching 'dist' 16:56:08 INFO - no previously-included directories found matching '.git*' 16:56:08 INFO - Installing collected packages: jsonschema, functools32 16:56:08 INFO - Running setup.py install for functools32 16:56:08 INFO - warning: no files found matching '*.txt' 16:56:08 INFO - no previously-included directories found matching 'build' 16:56:08 INFO - no previously-included directories found matching 'dist' 16:56:08 INFO - no previously-included directories found matching '.git*' 16:56:08 INFO - Successfully installed jsonschema functools32 16:56:08 INFO - Cleaning up... 16:56:08 INFO - Return code: 0 16:56:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:56:08 INFO - Using env: {'DISPLAY': ':0', 16:56:08 INFO - 'HOME': '/home/cltbld', 16:56:08 INFO - 'LANG': 'en_US.UTF-8', 16:56:08 INFO - 'LANGUAGE': 'en_US:en', 16:56:08 INFO - 'LOGNAME': 'cltbld', 16:56:08 INFO - 'MAIL': '/var/mail/cltbld', 16:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:08 INFO - 'MOZ_NO_REMOTE': '1', 16:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:08 INFO - 'NO_EM_RESTART': '1', 16:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:08 INFO - 'PWD': '/builds/slave/test', 16:56:08 INFO - 'SHELL': '/bin/bash', 16:56:08 INFO - 'SHLVL': '1', 16:56:08 INFO - 'TERM': 'linux', 16:56:08 INFO - 'TMOUT': '86400', 16:56:08 INFO - 'USER': 'cltbld', 16:56:08 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:08 INFO - '_': '/tools/buildbot/bin/python'} 16:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:56:08 INFO - Cleaning up... 16:56:08 INFO - Return code: 0 16:56:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:56:08 INFO - Using env: {'DISPLAY': ':0', 16:56:08 INFO - 'HOME': '/home/cltbld', 16:56:08 INFO - 'LANG': 'en_US.UTF-8', 16:56:08 INFO - 'LANGUAGE': 'en_US:en', 16:56:08 INFO - 'LOGNAME': 'cltbld', 16:56:08 INFO - 'MAIL': '/var/mail/cltbld', 16:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:08 INFO - 'MOZ_NO_REMOTE': '1', 16:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:08 INFO - 'NO_EM_RESTART': '1', 16:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:08 INFO - 'PWD': '/builds/slave/test', 16:56:08 INFO - 'SHELL': '/bin/bash', 16:56:08 INFO - 'SHLVL': '1', 16:56:08 INFO - 'TERM': 'linux', 16:56:08 INFO - 'TMOUT': '86400', 16:56:08 INFO - 'USER': 'cltbld', 16:56:08 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:08 INFO - '_': '/tools/buildbot/bin/python'} 16:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:10 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 16:56:10 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 16:56:10 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 16:56:10 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 16:56:10 INFO - Downloading docopt-0.6.1.tar.gz 16:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:10 INFO - Running setup.py install for blobuploader 16:56:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:10 INFO - Running setup.py install for requests 16:56:10 INFO - Running setup.py install for docopt 16:56:11 INFO - Successfully installed blobuploader requests docopt 16:56:11 INFO - Cleaning up... 16:56:11 INFO - Return code: 0 16:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:11 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')]} 16:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:11 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')]} 16:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:11 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:11 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 16:56:11 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 16:56:11 INFO - Using env: {'DISPLAY': ':0', 16:56:11 INFO - 'HOME': '/home/cltbld', 16:56:11 INFO - 'LANG': 'en_US.UTF-8', 16:56:11 INFO - 'LANGUAGE': 'en_US:en', 16:56:11 INFO - 'LOGNAME': 'cltbld', 16:56:11 INFO - 'MAIL': '/var/mail/cltbld', 16:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:11 INFO - 'MOZ_NO_REMOTE': '1', 16:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:11 INFO - 'NO_EM_RESTART': '1', 16:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:11 INFO - 'PWD': '/builds/slave/test', 16:56:11 INFO - 'SHELL': '/bin/bash', 16:56:11 INFO - 'SHLVL': '1', 16:56:11 INFO - 'TERM': 'linux', 16:56:11 INFO - 'TMOUT': '86400', 16:56:11 INFO - 'USER': 'cltbld', 16:56:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:11 INFO - '_': '/tools/buildbot/bin/python'} 16:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:11 INFO - Running setup.py (path:/tmp/pip-wOBCD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:11 INFO - Running setup.py (path:/tmp/pip-5NnNMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:11 INFO - Running setup.py (path:/tmp/pip-YKC7Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:11 INFO - Running setup.py (path:/tmp/pip-6JYHlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:11 INFO - Running setup.py (path:/tmp/pip-NaAXT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:11 INFO - Running setup.py (path:/tmp/pip-0wVJk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:11 INFO - Running setup.py (path:/tmp/pip-hU6Qup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:11 INFO - Running setup.py (path:/tmp/pip-xhu2Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:11 INFO - Running setup.py (path:/tmp/pip-I6IMkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:11 INFO - Running setup.py (path:/tmp/pip-reYn34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:12 INFO - Running setup.py (path:/tmp/pip-6rhDVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:12 INFO - Running setup.py (path:/tmp/pip-tjHx3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:12 INFO - Running setup.py (path:/tmp/pip-b_5U_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:12 INFO - Running setup.py (path:/tmp/pip-mehhN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:12 INFO - Running setup.py (path:/tmp/pip-w6FtA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:12 INFO - Running setup.py (path:/tmp/pip-Qarggc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:12 INFO - Running setup.py (path:/tmp/pip-zpVamF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:12 INFO - Running setup.py install for manifestparser 16:56:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:12 INFO - Running setup.py install for mozcrash 16:56:12 INFO - Running setup.py install for mozdebug 16:56:12 INFO - Running setup.py install for mozdevice 16:56:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:12 INFO - Running setup.py install for mozfile 16:56:13 INFO - Running setup.py install for mozhttpd 16:56:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozinfo 16:56:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozInstall 16:56:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozleak 16:56:13 INFO - Running setup.py install for mozlog 16:56:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for moznetwork 16:56:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozprocess 16:56:13 INFO - Running setup.py install for mozprofile 16:56:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozrunner 16:56:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozscreenshot 16:56:14 INFO - Running setup.py install for moztest 16:56:14 INFO - Running setup.py install for mozversion 16:56:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:14 INFO - Cleaning up... 16:56:14 INFO - Return code: 0 16:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:14 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')]} 16:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:14 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')]} 16:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:14 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:14 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 16:56:14 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 16:56:14 INFO - Using env: {'DISPLAY': ':0', 16:56:14 INFO - 'HOME': '/home/cltbld', 16:56:14 INFO - 'LANG': 'en_US.UTF-8', 16:56:14 INFO - 'LANGUAGE': 'en_US:en', 16:56:14 INFO - 'LOGNAME': 'cltbld', 16:56:14 INFO - 'MAIL': '/var/mail/cltbld', 16:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:14 INFO - 'MOZ_NO_REMOTE': '1', 16:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:14 INFO - 'NO_EM_RESTART': '1', 16:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:14 INFO - 'PWD': '/builds/slave/test', 16:56:14 INFO - 'SHELL': '/bin/bash', 16:56:14 INFO - 'SHLVL': '1', 16:56:14 INFO - 'TERM': 'linux', 16:56:14 INFO - 'TMOUT': '86400', 16:56:14 INFO - 'USER': 'cltbld', 16:56:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:14 INFO - '_': '/tools/buildbot/bin/python'} 16:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:14 INFO - Running setup.py (path:/tmp/pip-RZiswb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:14 INFO - Running setup.py (path:/tmp/pip-5VioBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:14 INFO - Running setup.py (path:/tmp/pip-TvbidO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:14 INFO - Running setup.py (path:/tmp/pip-kRbCF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:14 INFO - Running setup.py (path:/tmp/pip-7E1QSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:14 INFO - Running setup.py (path:/tmp/pip-_jyKKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:14 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)) 16:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:14 INFO - Running setup.py (path:/tmp/pip-QrCipJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:15 INFO - Running setup.py (path:/tmp/pip-JFz_i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:15 INFO - Running setup.py (path:/tmp/pip-TlX2Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:15 INFO - Running setup.py (path:/tmp/pip-pcuaCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:15 INFO - Running setup.py (path:/tmp/pip-cr6NbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:15 INFO - Running setup.py (path:/tmp/pip-V9HI0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:15 INFO - Running setup.py (path:/tmp/pip-twH8pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:15 INFO - Running setup.py (path:/tmp/pip-FqfXq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:15 INFO - Running setup.py (path:/tmp/pip-YWNFPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:15 INFO - Running setup.py (path:/tmp/pip-OslYVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:15 INFO - Running setup.py (path:/tmp/pip-Mmkhzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:15 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)) 16:56:15 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)) 16:56:15 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)) 16:56:15 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)) 16:56:15 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)) 16:56:15 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)) 16:56:15 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)) 16:56:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:16 INFO - Downloading blessings-1.6.tar.gz 16:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:16 INFO - Installing collected packages: blessings 16:56:16 INFO - Running setup.py install for blessings 16:56:17 INFO - Successfully installed blessings 16:56:17 INFO - Cleaning up... 16:56:17 INFO - Return code: 0 16:56:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:17 INFO - Reading from file tmpfile_stdout 16:56:17 INFO - Current package versions: 16:56:17 INFO - argparse == 1.2.1 16:56:17 INFO - blessings == 1.6 16:56:17 INFO - blobuploader == 1.2.4 16:56:17 INFO - docopt == 0.6.1 16:56:17 INFO - functools32 == 3.2.3-2 16:56:17 INFO - jsonschema == 2.5.1 16:56:17 INFO - manifestparser == 1.1 16:56:17 INFO - mozInstall == 1.13 16:56:17 INFO - mozcrash == 1.0 16:56:17 INFO - mozdebug == 0.1 16:56:17 INFO - mozdevice == 0.51 16:56:17 INFO - mozfile == 1.2 16:56:17 INFO - mozhttpd == 0.7 16:56:17 INFO - mozinfo == 0.10 16:56:17 INFO - mozleak == 0.1 16:56:17 INFO - mozlog == 3.5 16:56:17 INFO - moznetwork == 0.27 16:56:17 INFO - mozprocess == 0.25 16:56:17 INFO - mozprofile == 0.28 16:56:17 INFO - mozrunner == 6.13 16:56:17 INFO - mozscreenshot == 0.1 16:56:17 INFO - mozsystemmonitor == 0.3 16:56:17 INFO - moztest == 0.8 16:56:17 INFO - mozversion == 1.4 16:56:17 INFO - psutil == 3.1.1 16:56:17 INFO - requests == 1.2.3 16:56:17 INFO - wsgiref == 0.1.2 16:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:17 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')]} 16:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:17 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')]} 16:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:17 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:17 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 16:56:17 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 16:56:17 INFO - Using env: {'DISPLAY': ':0', 16:56:17 INFO - 'HOME': '/home/cltbld', 16:56:17 INFO - 'LANG': 'en_US.UTF-8', 16:56:17 INFO - 'LANGUAGE': 'en_US:en', 16:56:17 INFO - 'LOGNAME': 'cltbld', 16:56:17 INFO - 'MAIL': '/var/mail/cltbld', 16:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:17 INFO - 'MOZ_NO_REMOTE': '1', 16:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:17 INFO - 'NO_EM_RESTART': '1', 16:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:17 INFO - 'PWD': '/builds/slave/test', 16:56:17 INFO - 'SHELL': '/bin/bash', 16:56:17 INFO - 'SHLVL': '1', 16:56:17 INFO - 'TERM': 'linux', 16:56:17 INFO - 'TMOUT': '86400', 16:56:17 INFO - 'USER': 'cltbld', 16:56:17 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:17 INFO - '_': '/tools/buildbot/bin/python'} 16:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:56:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:56:18 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)) 16:56:18 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)) 16:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56:18 INFO - Installing collected packages: marionette-driver, simplejson 16:56:18 INFO - Running setup.py install for marionette-driver 16:56:19 INFO - Running setup.py install for simplejson 16:56:19 INFO - building 'simplejson._speedups' extension 16:56:19 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 16:56:19 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 16:56:20 INFO - Successfully installed marionette-driver simplejson 16:56:20 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:20 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')]} 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:20 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')]} 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:20 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 0x130d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, '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': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', '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 16:56:20 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 16:56:20 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 16:56:20 INFO - Using env: {'DISPLAY': ':0', 16:56:20 INFO - 'HOME': '/home/cltbld', 16:56:20 INFO - 'LANG': 'en_US.UTF-8', 16:56:20 INFO - 'LANGUAGE': 'en_US:en', 16:56:20 INFO - 'LOGNAME': 'cltbld', 16:56:20 INFO - 'MAIL': '/var/mail/cltbld', 16:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:20 INFO - 'MOZ_NO_REMOTE': '1', 16:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:20 INFO - 'NO_EM_RESTART': '1', 16:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:20 INFO - 'PWD': '/builds/slave/test', 16:56:20 INFO - 'SHELL': '/bin/bash', 16:56:20 INFO - 'SHLVL': '1', 16:56:20 INFO - 'TERM': 'linux', 16:56:20 INFO - 'TMOUT': '86400', 16:56:20 INFO - 'USER': 'cltbld', 16:56:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:20 INFO - '_': '/tools/buildbot/bin/python'} 16:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:20 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Running post-action listener: _resource_record_post_action 16:56:20 INFO - Running post-action listener: _start_resource_monitoring 16:56:20 INFO - Starting resource monitoring. 16:56:20 INFO - [mozharness: 2017-07-27 23:56:20.341504Z] Finished create-virtualenv step (success) 16:56:20 INFO - [mozharness: 2017-07-27 23:56:20.341970Z] Running install step. 16:56:20 INFO - Running pre-action listener: _resource_record_pre_action 16:56:20 INFO - Running main action method: install 16:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:20 INFO - Reading from file tmpfile_stdout 16:56:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:20 INFO - Reading from file tmpfile_stdout 16:56:20 INFO - Output received: 16:56:20 INFO - Usage: mozinstall [options] installer 16:56:20 INFO - Options: 16:56:20 INFO - -h, --help show this help message and exit 16:56:20 INFO - -d DEST, --destination=DEST 16:56:20 INFO - Directory to install application into. [default: 16:56:20 INFO - "/builds/slave/test"] 16:56:20 INFO - --app=APP Application being installed. [default: firefox] 16:56:20 INFO - mkdir: /builds/slave/test/build/application 16:56:20 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'] 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:38 INFO - Reading from file tmpfile_stdout 16:56:38 INFO - Output received: 16:56:38 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:38 INFO - Running post-action listener: _resource_record_post_action 16:56:38 INFO - [mozharness: 2017-07-27 23:56:38.704252Z] Finished install step (success) 16:56:38 INFO - [mozharness: 2017-07-27 23:56:38.704399Z] Running setup-mitmproxy step. 16:56:38 INFO - Running pre-action listener: _resource_record_pre_action 16:56:38 INFO - Running main action method: setup_mitmproxy 16:56:38 INFO - Skipping: mitmproxy is not required 16:56:38 INFO - Running post-action listener: _resource_record_post_action 16:56:38 INFO - [mozharness: 2017-07-27 23:56:38.704932Z] Finished setup-mitmproxy step (success) 16:56:38 INFO - [mozharness: 2017-07-27 23:56:38.705036Z] Running run-tests step. 16:56:38 INFO - Running pre-action listener: _resource_record_pre_action 16:56:38 INFO - Running pre-action listener: _set_gcov_prefix 16:56:38 INFO - Running main action method: run_tests 16:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:38 INFO - Python 2.7.3 16:56:38 INFO - Return code: 0 16:56:38 INFO - grabbing minidump binary from tooltool 16:56:38 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')]} 16:56:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1679eb0>, '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 0x167adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 16:56:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:56:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 16:56:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:38 INFO - Return code: 0 16:56:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:38 INFO - ENV: RUST_BACKTRACE is now 1 16:56:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 16:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 16:56:38 INFO - Using env: {'DISPLAY': ':0', 16:56:38 INFO - 'HOME': '/home/cltbld', 16:56:38 INFO - 'LANG': 'en_US.UTF-8', 16:56:38 INFO - 'LANGUAGE': 'en_US:en', 16:56:38 INFO - 'LOGNAME': 'cltbld', 16:56:38 INFO - 'MAIL': '/var/mail/cltbld', 16:56:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:38 INFO - 'MOZ_NO_REMOTE': '1', 16:56:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:38 INFO - 'NO_EM_RESTART': '1', 16:56:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:38 INFO - 'PWD': '/builds/slave/test', 16:56:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:38 INFO - 'RUST_BACKTRACE': '1', 16:56:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:38 INFO - 'SHELL': '/bin/bash', 16:56:38 INFO - 'SHLVL': '1', 16:56:38 INFO - 'STYLO_FORCE_ENABLED': '1', 16:56:38 INFO - 'TERM': 'linux', 16:56:38 INFO - 'TMOUT': '86400', 16:56:38 INFO - 'USER': 'cltbld', 16:56:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074', 16:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:38 INFO - '_': '/tools/buildbot/bin/python'} 16:56:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 16:56:39 INFO - mozversion application_buildid: 20170727231007 16:56:39 INFO - mozversion application_changeset: a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c 16:56:39 INFO - mozversion application_display_name: Nightly 16:56:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:39 INFO - mozversion application_name: Firefox 16:56:39 INFO - mozversion application_remotingname: firefox 16:56:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:39 INFO - mozversion application_vendor: Mozilla 16:56:39 INFO - mozversion application_version: 56.0a1 16:56:39 INFO - mozversion platform_buildid: 20170727231007 16:56:39 INFO - mozversion platform_changeset: a4afa89bfdd10a903cfa9aa5a5bd1624dc85548c 16:56:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:39 INFO - mozversion platform_version: 56.0a1 16:56:39 INFO - using testdate: 1501199799 16:56:39 INFO - actual date: 1501199799 16:56:39 INFO - starting webserver on 'localhost:37672' 16:56:39 INFO - SUITE-START | Running 2 tests 16:56:39 INFO - TEST-START | dromaeo_css 16:56:39 INFO - Initialising browser for dromaeo_css test... 16:56:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37672/getInfo.html -profile /tmp/tmpV4T_dk/profile 16:56:39 INFO - TEST-INFO | started process 17397 (/builds/slave/test/build/application/firefox/firefox http://localhost:37672/getInfo.html) 16:56:44 INFO - TEST-INFO | 17397: exit 0 16:56:44 INFO - Browser initialized. 16:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:44 INFO - TEST-INFO | started process 17621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV4T_dk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:45 INFO - PID 17621 | 16:56:45 INFO - PID 17621 | (/builds/slave/test/build/application/firefox/firefox:17676): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:45 INFO - PID 17621 | 16:56:56 INFO - PID 17621 | RSS: Main: 173129728 16:56:56 INFO - PID 17621 | 16:59:55 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37672/tests/dromaeo/cssquery-ext.html) 16:59:57 INFO - PID 17621 | RSS: Main: 175108096 16:59:57 INFO - PID 17621 | 17:02:59 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-ext.html (next: http://localhost:37672/tests/dromaeo/cssquery-jquery.html) 17:02:59 INFO - PID 17621 | RSS: Main: 172036096 17:02:59 INFO - PID 17621 | 17:06:01 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37672/tests/dromaeo/cssquery-mootools.html) 17:06:02 INFO - PID 17621 | RSS: Main: 172707840 17:06:02 INFO - PID 17621 | 17:09:04 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37672/tests/dromaeo/cssquery-prototype.html) 17:09:04 INFO - PID 17621 | RSS: Main: 171053056 17:09:04 INFO - PID 17621 | 17:12:08 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37672/tests/dromaeo/cssquery-yui.html) 17:12:09 INFO - PID 17621 | RSS: Main: 172670976 17:12:09 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | Cycle 1(1): loaded http://localhost:37672/tests/dromaeo/cssquery-yui.html (next: http://localhost:37672/tests/dromaeo/cssquery-dojo.html) 17:15:11 INFO - PID 17621 | RSS: Main: 177336320 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | __start_tp_report 17:15:11 INFO - PID 17621 | _x_x_mozilla_page_load 17:15:11 INFO - PID 17621 | _x_x_mozilla_page_load_details 17:15:11 INFO - PID 17621 | |i|pagename|runs| 17:15:11 INFO - PID 17621 | |0;dojo.html;3164.8734050637963;3187.6015498062748;3210.357928414316;3224.6291676457186;3252.3657886712085;6089.45194932456;6122.969385153074;6153.138560601519;6181.28915174755;6245.032020036891;6083.665398403086;6240.3759624037575;6289.025201093827;6297.023961285997;6326.304106548288;5649.717514124277;5665.1785491103765;5758.309002919645;5787.826365209051;5793.420657934215;5649.717514124298;5717.342505611846;5739.827805165852;5748.48263656273;5805.12923061542;5565.526930210916;5612.354579223401;5643.238162848024;5694.032014557493;5711.200431939553;5584.748686309126;5628.605997580171;5651.604387692863;5658.603897727161;5667.943320566783;5502.119660854244;5558.610897237195;5639.379668236532;5643.8589035274035;5646.661200327952;6040.758369665208;6046.818595442144;6087.756489740405;6110.480609148228;6128.509719222451;6686.83282917926;6696.430803381719;6700.765473208463;6704.7988560343265;6719.428848547879;6762.087118239024;6772.627505487246;6775.356341147583;6775.4918381121615;6782.186137663462;6169.629822210682;6206.937930620727;6231.6572588507615;6240.4071613196675;6264.812055638338;6844.452443804484;6897.103376561015;6960.79117626472;6989.720411183495;6995.440364770806;6439.967800160969;6467.644279564575;6558.475321974231;6564.409203171737;6581.3418658133805;6716.46268298535;6720.294369091175;6732.427743641845;6739.730410783612;6760.019797129388;6686.966565167143;6701.262861085277;6764.425023872927;6770.4922130839395;6777.932220677829;6693.397594216543;6710.328967103348;6782.660866956731;6783.321667833177;6818;5387.676739395649;5436.21174929633;5456.7544460499375;5519.530839878575;5545.195946587723;4667.836625718083;4685.0629874025335;4700.670953033255;4729.881752956135;4765.26138448541;5895.027320492157;5908.14331921869;5912.408759124053;5915.112733089984;5928.911066334009;6710.429613482908;6725.630090345078;6809.489288303397;6814.114165158498;6848.7260509580055;5838.474537291664;5858.619189752738;5916.852078698067;5939.287285525765;5941.7623295067715;5891.911621325684;5951.464368206882;5982.042873140364;5997.820065398045;6035.064564992434;6393.104965304954;6510.674466276667;6544.443722283564;6547.869042619121;6551.115599394021;6689.866202675822;6776;6781.355771201728;6786.355296246848;6793.116894803644;6522.315156908457;6527.445167160845;6561.311062338576;6564.310747371457;6564.573302735307;6570.901436478553;6612.636305003079;6696.732130714717;6697.799066028027;6703.430208432338;6619.172603424572;6734.932650673627;6749.5612785168805;6751.088603038724;6829.453643708591;6441.71012304438;6451.677416129269;6468.514861385321;6475.3200913903365;6494.188226471691;6350.142730731477;6447.129637498878;6453.9354606453335;6463.15978922737;6465.741370345134;5459.7270136492225;6295.433410993032;6390.7763228286785;6391.872162556816;6555.147830781968;6507.642079685663;6519.934800651933;6561.442277406283;6615.106960560262;6624.966875165594;6223.657698826427;6292.968535157295;6329.683515824098;6361.363863613787;6364.172657554488 17:15:11 INFO - PID 17621 | |1;ext.html;823.460633285198;871.4945331707609;898.8157427727313;899.2446345070142;1162.2968104296895;31038.224044398903;31552.684473155292;41757.37363939543;41965;42042.948926276855;42941.570584294146;43413.131737365235;43419.565804341946;43420.3486947696;43529.34705979413;7745.7676269712;7760.650770715303;7903.48627339224;7976.641051152683;7994.760157195265;7817.5309481431295;7909.841803163933;7910.762677119696;7912.881306780403;7942.841143177162;7927.4847134936335;7930.682772689085;7933.0876949150725;7962;7991.240832120969;7885.881711774328;7896.249856263646;7930.325922296583;7939.325157361631;7947.125816160218;7793.571353575551;7806.804829879242;7861.174576669425;7863.960680196562;7881.763547093597;38871.222575548614;39184.60815391838;39241;39272.41091383631;39283.41074883879;3414.5048967899515;3457.343104810078;3480.1995541025453;3481.1819222482695;3485.4597537381746;31297.217569560715;31362.52956205659;31382.52926206109;31436.371272574648;31512;4713.6936099153445;4829.758512074382;4864.537868902448;4885.706857588556;4906.803727850882;186670;187276;188383;188635;189039.05480472647;49419.75290123526;49490.010199796525;49538.50461495411;49630.25554616684;49704;51740.22389664158;51777;51934.740326298124;52124.21813672798;52135.21797173045;14909.70180596382;16593.087380193963;16859.747103793452;16925.576860578585;16941.576460588585;12574.43415046325;12577.622671319876;12588.937055314847;13861.445542178402;14015.719685606231;14762.335694893542;14838.554843354717;14849.480268190777;14937;14972.1016738996;5745.741441635137;5749.084532724544;5881.206037185011;6022.488088512438;6050.909236361458;958.2382006305004;970.5438443931341;985.4776968206862;1013.1287093099928;1029.6653587584065;28532;28939.276518087216;29002.564961525593;29331;29946;1061.808874402615;1082.4587706146926;1092.5356723392526;1093.2292733622776;1106.6016234155697;12106.576269830513;12434.564790232298;12650.493980240688;12691.555795547112;16162.434314798926;222440;222775;222852;223254;223987;61744.691276544225;62074.689626551575;62176.067358989654;62183.06725399123;62745.68627156835;1500.2648702135875;1524.8932574719886;1547.3501129525625;1552.0765144738862;1558.9220538973007;27234;28040.57939130874;28216.29459263535;28227.858860705564;28371.57442638321;38756.6124338753;39073.2185356297;39194.608053919095;39428.2114357717;39501.40747888727;189221;189683;190150.19699605653;190473;191007;32156.51765223477;32570;32609.18477038093;34808;35820;44402.55597443984;44802.55197447984;44807.77596111999;45016.32475512935;45739.77130114328;29605.85197074001;29989.70010299869;31974.840125799223;32019.6798032026;32105.678943211202;30089.548656770603;31549;31577;31643;31772.364552708354;35269;36070;36108.458373123896;36199.45700814542;36443.63556364403;31161.532577011818;31576.368472629958;32048.67951320457;32139.67860321367;32173.67826321707;23307.18424855122;23621;23628.375642890565;23875.761242387354;24045.158419455936 17:15:11 INFO - PID 17621 | |2;jquery.html;571.9142128680697;577.7082573300482;577.80354679409;582.36522190812;582.7581553655233;22096.668549971724;22256.443588910264;23027.194048208316;23079.884600576996;23121.537569248627;25806.35484112898;26212.737872621266;26326.210213693572;26374;26408.339791505223;6509.121268628734;6641.435477984377;6671.266160722316;6682;6694.73221071159;6013.488853447462;6577.309382514839;6578.177727784027;6649.833754156137;6670.899936500957;6520.347965203489;6535.673216339188;6536.640484773336;6545.280019197909;6555.213374395055;6542.41118299353;6544.3782840630065;6547.47620190386;6551.279359270524;6564.5404821662505;6060.666663333515;6077.939220607782;6103.511719062509;6112.144299798032;6112.694365281718;28412.857935710188;28875;29296.267593310124;29423.2644183895;29853.850730746424;1831.38648552735;1890.5179179309325;1890.8203720646516;1891.1111777464569;1891.8013608571039;19070.80929190704;19305.03474826253;19307.613847722965;19360.225590976344;19387.224511019544;2258.3450799268194;2363.2555744940287;2402.1952645863657;2405.20628192696;2406.9879650601633;124992;127083.36458317742;127554.36222818919;127922.36038819839;127985.99999999907;14352.784708229385;14682.486112986207;14968.101913885203;15231.562949927958;15234.162121083225;22591.774082259297;22601.88699056494;22739;22745.203917862797;22780.43048923757;10225.948870255601;10529.894701053045;10668.413237271869;10719.19606029551;10857.45712714361;9942.602295908227;9985.45080020606;10076.29465937392;10200.846987295197;10219.386836789816;7741.380689544823;8958.596863141174;9121.908780912107;9289.071092890792;9323.580438880266;2596.415806443573;2611.9496195486454;2655.7650692428115;2770.48745981994;2831.0940499040107;936.9340996771891;967.5307475874196;967.7919247361851;984.158544444504;988.8813342398959;19153.52116197106;19266.71099933502;22308.665370019462;23031;23845.880770596035;1021.2085633633993;1021.2493817044466;1030.5877648940484;1064.797688439194;1070.5931745936493;10667.83998240027;11086.833697494543;11109.722256943642;11132.777344453065;11150.832737508943;467579;472150;484225;485005;506582;118287.40856295664;118811.40594296974;119335;119598;122465;1225.6997035726126;1283.3454937981696;1315.7500074985915;1320.7160460501038;1321.7026169112064;20139.899300503403;20413.183472660927;20734.27430040002;20982.37052888416;21379.46551336229;57098.714506427204;59142.70428647829;59840.70079649574;60739.39260607337;62079.06881396873;74896.2510374911;75241;75642.62178689071;75825.6208718975;76053.23946760461;12602.684932876384;13030.47878084866;14365.20991345486;14891.40434382656;14895.92552037233;23414.88292558526;24168.395790105387;24227.636585451586;24398.146064887645;24905.87547062253;18655.253789848255;18697;18740.156692949124;18943.147558360182;18971.33600323982;15817.920910395374;16063.839361606702;16197;16373;16915.492535223962;18028.81971180324;18141.546461338574;18218.90890545592;18380.264789408273;18700.81299186991;13909.51316703951;14018.859811401755;14027.579172624837;14149.858501415265;14187.432502700189;18884.527886802938;18885.43343699691;19048;19120.52198694988;19239.903800480908 17:15:11 INFO - PID 17621 | |3;mootools.html;1328.9667758306043;1375.6010756880505;1392.4778208171936;1396.7416028034809;1412.3573773932858;13632.522861699843;13909.93045034776;14036.298185090744;14043.859561404382;14094;14260.429582816674;14584.562463126096;14588.708225835477;14599.197044162567;14621.268936553157;2653.150991682662;2686.7044625091225;2689.973100268992;2692.219256415637;2692.609571612115;2592.338953566838;2641.3264617522505;2645.9470810583775;2679.1025006622804;2680.530907091261;2731.576605626131;2765.0737003103986;2771.5565509518483;2778.2776478115634;2778.7360200780995;2592.5722255827764;2615.555355589545;2630.2240838952557;2631.999840060774;2683.154806236049;2632.7893768498475;2641.3660721426913;2644.1274379454926;2660.8536530490815;2674;13745.450181992708;13858.514951976633;13884.930575347058;13895.305234738222;13922;7425.702971881118;7604.391648668094;7651.846963060708;7655.50239234448;7679.232076792332;5001.624878134118;5015.799368025275;5109.6678715883345;5193.480651934814;5264.736763161826;1829.4968883556994;1845.769278840145;1858.2845604442252;1873.4286042756953;1883.4443839067508;22554.774452255595;22752.65871011936;22758.54482910349;22797.658035129487;22879.31362059124;6342.4926005919415;6474.870502589922;6613.735450581923;6649.667516624149;6698.39714425704;15588.922055389878;15654.139022353653;15673.84326156724;15675.686486270211;15702.607434814221;7186.245444228385;7497.437692173109;7545.320921117016;7604.505707129129;7623.847523049619;6904.275051119661;7047.823804404931;7109.644517774091;7113.359797618135;7113.75101871432;5061.468545802712;5089.592832573385;5174.146265866165;5198.9740051299505;5201.609879258995;1413.5264686329988;1416.9291535423395;1503.090630168754;1520.4070412539118;1546.621077835915;830.5307501261889;839.6851180807197;850.141357229203;855.4909828651943;855.623525648725;7420.738474459355;7632.122305934889;7637.15991240963;7658.119316278699;7678.616069196518;944.6929747831982;946.2524605561667;991.0683957080322;994.1301361308855;1005.0100650859044;4583.427071616048;4680.81276748933;4781.808727650925;4807.543283388072;4912.680675756064;18228.908855455637;18615.813841861407;18800.059997000095;19076.2369505221;19173.90413047926;18997.81002189988;19027.524311892037;19078.427647170607;19265.325713599956;19272.518187045156;10058.446785426871;10539.367637941748;10557.419341936267;10565.366078035342;10579.471026448648;7191.20896701352;7545.886811697719;7578.204288549623;7726.111497177896;7762.223777622193;16011.199440028186;16465.670686585963;16607.50177494677;16800.159992000594;17042.403515876886;16621.667566648357;16916.57708557296;16984.57538561546;17166.828331716522;17337.13314334253;11033.117350611772;11202.38386888729;11207.551697931991;11210.327380357205;11240.15698822608;12311.815322769986;12543.372831358578;12584.748305033665;12611.43248553799;12618.432170552163;10036.19710423179;10382.636607718996;10468.738281543023;10560;10696.14430845515;9574.138327550554;10035.949820250851;10173.389596624227;10179.541920613443;10238;8833.779155521164;8912.910870891208;8933.374663773473;8960.327975402;8962;6164.137020816999;6210.596311239755;6518;6620.900686489803;6663.233728121328;7118.822029449305;7159.319864612853;7162.2121566628675;7167.462440317101;7223.205447400886 17:15:11 INFO - PID 17621 | |4;prototype.html;497.4929489188345;501.1963724804789;513.0687801640023;516.3700285651504;523.202116771923;6237.035333869828;6284.08880712297;6301.4013668701455;6339.651319177444;6352.5235607329405;5903.586748927566;6095.146679464879;6101.725422355994;6141.556734167467;6213.161223234862;4876.244182151772;4959.528844759742;4967.155583550796;4968.155413579682;5013.3232013678235;4847.781849816749;4872.585830204437;4921.704697718131;4941.4811444798315;4974.179260422026;4719.221328480814;4849.5877850382585;4878.951210487885;4889.33993910821;4927.6550641455115;4890.339804126433;4928.186849169901;4939.431965323998;4940.073371385162;4976.87557811054;4357;4368.584984426474;4394.934075988863;4400.44994375703;4425.845095421645;5978.40215978403;6012.609180403259;6020.939790602081;6029.577929544934;6035.547333949928;5677.829665110054;5685.2091591148655;5717.371089180187;5721.942780572224;5723.656580605136;6423.518236132309;6431.742730290783;6489.1888513935755;6490.772822951221;6563.50773691975;4828.444728856191;4832.154372984749;4856.538628830291;4860.1737704590305;4873.805047798084;6832.795016149524;6949.89575156373;6983.685734141975;6992.860142797217;7008.123984501988;4941.332920055818;4944.381952255968;4952.554270115635;4971.751412429364;5002.399712034579;4927.965127323302;5059.392872855281;5064.417591976896;5086.465921078234;5089.134847075932;5721.885562288731;5724.685142317129;5739.278216535106;5752.453516915886;5752.791913698086;6469.902951455732;6571.929842099723;6581.901271480931;6591.373819487141;6592.604443733391;1672.1304921440783;1688.7804585404065;1706.9146542672818;1744.1366523570914;1761.5596100974756;1192.6940000699221;1230.6677197156896;1235.3576140406938;1240.4232032105115;1243.154654834721;5629.662220266797;5752.33848107473;5808.767649293981;5815.592908496449;5836.503897168704;6516.739330426824;6586.341365863471;6690.130283063268;6697.330266973361;6726.596404215763;5775.393583673737;5776.7111644418455;5780.797672081457;5873.442023007808;5898.292204935349;3547.396942519778;3566.821658917044;3567.661072198137;3598.7480876338404;3643.8178091095338;6642.402183803384;6664.133662623828;6667.266600673922;6687.966560167168;6694.196696396463;6924.849193616892;6938.965305173442;6950.895736563955;7012.474064445187;7016.859662806715;6489.253735820441;6559.5408321418;6654.866902661823;6672.432843208382;6703.765368212089;6638.236602790547;6657.633830139195;6660.200775906922;6664.566803157779;6726.192856857208;6548.967255163694;6563.409293163638;6638.402543771083;6747.730090796314;6752.122224110834;6469.935300646934;6569.408753212234;6605.702743376656;6615.636140012345;6651.235107962646;4951.9752401237765;4980.850574482772;5003.77483013258;5010.799568017384;5029.321041659329;6623.536352455475;6653.467722582279;6740.595564266159;6759.208809665541;6763.49750592284;6468.8059358219325;6474.223093228843;6491.4482269005775;6502.479801615954;6561.671916404256;6478.967605162133;6496.252930913006;6501.577397469338;6562.639054852029;6608.173978252718;6204.658743769136;6298.244210694746;6339.175907132043;6372.840678983062;6492.707828147651;6368.758616555709;6390.872182556416;6444.677766111582;6453.612783233021;6464.385883341075;6281.654509002049;6320.873582528232;6325.810225693236;6387.329330420424;6409.647469389229 17:15:11 INFO - PID 17621 | |5;yui.html;867.8611422172454;887.2414085956507;901.6213190460006;906.274980015987;912.4662072687478;16912;17480.47558573243;17532.912335438337;17578.472645820646;17597.296108155657;20769;20983.055762490723;21005;21040.368788936317;21066.89466552669;1049.1344640671457;1070.3524367757511;1074.1192222377654;1074.248026381532;1074.5433190893839;970.9465979371132;1040.5889673578931;1055.9313644613114;1056.8309070548714;1062.5537274344756;1115.8884111588857;1121.4336759936261;1124.7525544380223;1125.926814757038;1128.05807151029;1103.1560855945208;1106.5241945963232;1107.9446027698664;1108.6507750058706;1109.295597295719;809.2676128104075;810.6676262732251;813.1258896686027;813.4102775487784;814.8533264012475;17704.291828326852;17916.372926947493;18760.906195468935;19075;19220.135093920668;20127.396178114534;20598.897005515028;20881.37355879326;20964;21024.684629730567;16069.598260043476;16413;16414.83585164157;16460.42388516408;16526.83473165277;3482.564679415073;3483.721302295836;3499.5450591423205;3501.037214765934;3511.2099777549847;119234.4038279803;123558;124496;127955;130620;15072.54782356531;15291.388344466319;15312.157831319384;15498.147601882005;15500.767488487681;29921.251968700522;30272.84863575668;30304.84847575748;30337;30349.393012140074;7969.561674107864;7985.600719963979;8034.517928924283;8037.316828069563;8060.959695201486;3836.9424458633143;3920.9607903920596;3932.9213415731524;3933.7049721270446;3934.9803250983564;4854.296127061627;5015.14742493777;5512.641678290898;5690.9146362804595;5736.110902810071;1031.5461197073264;1055.5988724284723;1068.8396740488988;1070.4059247117925;1072.340510585984;618.6288227063816;620.3889169168456;639.1212083385345;651.8794023105646;674.4098913450731;11356.26184298018;13127.146735462164;13292.468301267842;13370;13410.530631428048;621.2482895696168;625.2434554189482;644.4779728419995;645.6674812471581;665.1685393258427;5262.473752624707;5271.604629652791;5373.516383525502;5390.730463476811;5494.780208791683;98967.50516247372;102585.48707256417;104891;105678;106393.46803265934;91395;94361;94841.5257923706;95375;101782.49108754408;88460.5576972111;88682.55658721794;88833.55583222171;90014.09985900189;95811;11633.0111940486;11661.416929153338;11893.937532253569;12457.377131143225;12498.25010499373;34369.656303437645;36424.81787591045;36990.815045924595;37320.81339593285;37746.43380349242;44090.55909440993;45027.77486112549;45394;46700.532994670975;48126.5187348136;17490.300387984847;17774.644507110042;17945.820541794415;18361.173747181143;18537.258509659463;16929.49211523607;19868.10593523266;19929;19943.900280498503;21280.042398091813;18160.545986350447;18710.438686839418;19132.426027219204;19857;20183.899080504503;19153.712694309317;19398.61202775908;19447.902760486108;19838.50403739918;19932.70100948516;17312.740308895627;17372.934260928647;17722.734158987885;17859.83911045778;18113.18490667897;12473.251604903735;13426.261555614536;13580.388882500114;13803.79294310566;14186.290685465892;13820.23988680592;14320.57038288853;14357.712845743235;14616.780748288571;14702.779458308349 17:15:11 INFO - PID 17621 | __end_tp_report 17:15:11 INFO - PID 17621 | __start_cc_report 17:15:11 INFO - PID 17621 | _x_x_mozilla_cycle_collect,378 17:15:11 INFO - PID 17621 | __end_cc_report 17:15:11 INFO - PID 17621 | __startTimestamp1501200911616__endTimestamp 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | ------- Summary: start ------- 17:15:11 INFO - PID 17621 | Number of tests: 6 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#0] dojo.html Cycles:165 Average:6163.35 Median:6364.17 stddev:726.52 (11.4%) stddev-sans-first:689.62 17:15:11 INFO - PID 17621 | Values: 3164.9 3187.6 3210.4 3224.6 3252.4 6089.5 6123.0 6153.1 6181.3 6245.0 6083.7 6240.4 6289.0 6297.0 6326.3 5649.7 5665.2 5758.3 5787.8 5793.4 5649.7 5717.3 5739.8 5748.5 5805.1 5565.5 5612.4 5643.2 5694.0 5711.2 5584.7 5628.6 5651.6 5658.6 5667.9 5502.1 5558.6 5639.4 5643.9 5646.7 6040.8 6046.8 6087.8 6110.5 6128.5 6686.8 6696.4 6700.8 6704.8 6719.4 6762.1 6772.6 6775.4 6775.5 6782.2 6169.6 6206.9 6231.7 6240.4 6264.8 6844.5 6897.1 6960.8 6989.7 6995.4 6440.0 6467.6 6558.5 6564.4 6581.3 6716.5 6720.3 6732.4 6739.7 6760.0 6687.0 6701.3 6764.4 6770.5 6777.9 6693.4 6710.3 6782.7 6783.3 6818.0 5387.7 5436.2 5456.8 5519.5 5545.2 4667.8 4685.1 4700.7 4729.9 4765.3 5895.0 5908.1 5912.4 5915.1 5928.9 6710.4 6725.6 6809.5 6814.1 6848.7 5838.5 5858.6 5916.9 5939.3 5941.8 5891.9 5951.5 5982.0 5997.8 6035.1 6393.1 6510.7 6544.4 6547.9 6551.1 6689.9 6776.0 6781.4 6786.4 6793.1 6522.3 6527.4 6561.3 6564.3 6564.6 6570.9 6612.6 6696.7 6697.8 6703.4 6619.2 6734.9 6749.6 6751.1 6829.5 6441.7 6451.7 6468.5 6475.3 6494.2 6350.1 6447.1 6453.9 6463.2 6465.7 5459.7 6295.4 6390.8 6391.9 6555.1 6507.6 6519.9 6561.4 6615.1 6625.0 6223.7 6293.0 6329.7 6361.4 6364.2 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#1] ext.html Cycles:180 Average:37811.61 Median:19144.10 stddev:52056.89 (271.9%) stddev-sans-first:52128.84 17:15:11 INFO - PID 17621 | Values: 823.5 871.5 898.8 899.2 1162.3 31038.2 31552.7 41757.4 41965.0 42042.9 42941.6 43413.1 43419.6 43420.3 43529.3 7745.8 7760.7 7903.5 7976.6 7994.8 7817.5 7909.8 7910.8 7912.9 7942.8 7927.5 7930.7 7933.1 7962.0 7991.2 7885.9 7896.2 7930.3 7939.3 7947.1 7793.6 7806.8 7861.2 7864.0 7881.8 38871.2 39184.6 39241.0 39272.4 39283.4 3414.5 3457.3 3480.2 3481.2 3485.5 31297.2 31362.5 31382.5 31436.4 31512.0 4713.7 4829.8 4864.5 4885.7 4906.8 186670.0 187276.0 188383.0 188635.0 189039.1 49419.8 49490.0 49538.5 49630.3 49704.0 51740.2 51777.0 51934.7 52124.2 52135.2 14909.7 16593.1 16859.7 16925.6 16941.6 12574.4 12577.6 12588.9 13861.4 14015.7 14762.3 14838.6 14849.5 14937.0 14972.1 5745.7 5749.1 5881.2 6022.5 6050.9 958.2 970.5 985.5 1013.1 1029.7 28532.0 28939.3 29002.6 29331.0 29946.0 1061.8 1082.5 1092.5 1093.2 1106.6 12106.6 12434.6 12650.5 12691.6 16162.4 222440.0 222775.0 222852.0 223254.0 223987.0 61744.7 62074.7 62176.1 62183.1 62745.7 1500.3 1524.9 1547.4 1552.1 1558.9 27234.0 28040.6 28216.3 28227.9 28371.6 38756.6 39073.2 39194.6 39428.2 39501.4 189221.0 189683.0 190150.2 190473.0 191007.0 32156.5 32570.0 32609.2 34808.0 35820.0 44402.6 44802.6 44807.8 45016.3 45739.8 29605.9 29989.7 31974.8 32019.7 32105.7 30089.5 31549.0 31577.0 31643.0 31772.4 35269.0 36070.0 36108.5 36199.5 36443.6 31161.5 31576.4 32048.7 32139.7 32173.7 23307.2 23621.0 23628.4 23875.8 24045.2 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#2] jquery.html Cycles:180 Average:34745.85 Median:22670.44 stddev:81344.50 (358.8%) stddev-sans-first:81532.23 17:15:11 INFO - PID 17621 | Values: 571.9 577.7 577.8 582.4 582.8 22096.7 22256.4 23027.2 23079.9 23121.5 25806.4 26212.7 26326.2 26374.0 26408.3 6509.1 6641.4 6671.3 6682.0 6694.7 6013.5 6577.3 6578.2 6649.8 6670.9 6520.3 6535.7 6536.6 6545.3 6555.2 6542.4 6544.4 6547.5 6551.3 6564.5 6060.7 6077.9 6103.5 6112.1 6112.7 28412.9 28875.0 29296.3 29423.3 29853.9 1831.4 1890.5 1890.8 1891.1 1891.8 19070.8 19305.0 19307.6 19360.2 19387.2 2258.3 2363.3 2402.2 2405.2 2407.0 124992.0 127083.4 127554.4 127922.4 127986.0 14352.8 14682.5 14968.1 15231.6 15234.2 22591.8 22601.9 22739.0 22745.2 22780.4 10225.9 10529.9 10668.4 10719.2 10857.5 9942.6 9985.5 10076.3 10200.8 10219.4 7741.4 8958.6 9121.9 9289.1 9323.6 2596.4 2611.9 2655.8 2770.5 2831.1 936.9 967.5 967.8 984.2 988.9 19153.5 19266.7 22308.7 23031.0 23845.9 1021.2 1021.2 1030.6 1064.8 1070.6 10667.8 11086.8 11109.7 11132.8 11150.8 467579.0 472150.0 484225.0 485005.0 506582.0 118287.4 118811.4 119335.0 119598.0 122465.0 1225.7 1283.3 1315.8 1320.7 1321.7 20139.9 20413.2 20734.3 20982.4 21379.5 57098.7 59142.7 59840.7 60739.4 62079.1 74896.3 75241.0 75642.6 75825.6 76053.2 12602.7 13030.5 14365.2 14891.4 14895.9 23414.9 24168.4 24227.6 24398.1 24905.9 18655.3 18697.0 18740.2 18943.1 18971.3 15817.9 16063.8 16197.0 16373.0 16915.5 18028.8 18141.5 18218.9 18380.3 18700.8 13909.5 14018.9 14027.6 14149.9 14187.4 18884.5 18885.4 19048.0 19120.5 19239.9 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#3] mootools.html Cycles:180 Average:8561.50 Median:2637.06 stddev:5838.94 (221.4%) stddev-sans-first:5830.03 17:15:11 INFO - PID 17621 | Values: 1329.0 1375.6 1392.5 1396.7 1412.4 13632.5 13909.9 14036.3 14043.9 14094.0 14260.4 14584.6 14588.7 14599.2 14621.3 2653.2 2686.7 2690.0 2692.2 2692.6 2592.3 2641.3 2645.9 2679.1 2680.5 2731.6 2765.1 2771.6 2778.3 2778.7 2592.6 2615.6 2630.2 2632.0 2683.2 2632.8 2641.4 2644.1 2660.9 2674.0 13745.5 13858.5 13884.9 13895.3 13922.0 7425.7 7604.4 7651.8 7655.5 7679.2 5001.6 5015.8 5109.7 5193.5 5264.7 1829.5 1845.8 1858.3 1873.4 1883.4 22554.8 22752.7 22758.5 22797.7 22879.3 6342.5 6474.9 6613.7 6649.7 6698.4 15588.9 15654.1 15673.8 15675.7 15702.6 7186.2 7497.4 7545.3 7604.5 7623.8 6904.3 7047.8 7109.6 7113.4 7113.8 5061.5 5089.6 5174.1 5199.0 5201.6 1413.5 1416.9 1503.1 1520.4 1546.6 830.5 839.7 850.1 855.5 855.6 7420.7 7632.1 7637.2 7658.1 7678.6 944.7 946.3 991.1 994.1 1005.0 4583.4 4680.8 4781.8 4807.5 4912.7 18228.9 18615.8 18800.1 19076.2 19173.9 18997.8 19027.5 19078.4 19265.3 19272.5 10058.4 10539.4 10557.4 10565.4 10579.5 7191.2 7545.9 7578.2 7726.1 7762.2 16011.2 16465.7 16607.5 16800.2 17042.4 16621.7 16916.6 16984.6 17166.8 17337.1 11033.1 11202.4 11207.6 11210.3 11240.2 12311.8 12543.4 12584.7 12611.4 12618.4 10036.2 10382.6 10468.7 10560.0 10696.1 9574.1 10035.9 10173.4 10179.5 10238.0 8833.8 8912.9 8933.4 8960.3 8962.0 6164.1 6210.6 6518.0 6620.9 6663.2 7118.8 7159.3 7162.2 7167.5 7223.2 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#4] prototype.html Cycles:180 Average:5500.67 Median:6065.35 stddev:1554.34 (25.6%) stddev-sans-first:1512.66 17:15:11 INFO - PID 17621 | Values: 497.5 501.2 513.1 516.4 523.2 6237.0 6284.1 6301.4 6339.7 6352.5 5903.6 6095.1 6101.7 6141.6 6213.2 4876.2 4959.5 4967.2 4968.2 5013.3 4847.8 4872.6 4921.7 4941.5 4974.2 4719.2 4849.6 4879.0 4889.3 4927.7 4890.3 4928.2 4939.4 4940.1 4976.9 4357.0 4368.6 4394.9 4400.4 4425.8 5978.4 6012.6 6020.9 6029.6 6035.5 5677.8 5685.2 5717.4 5721.9 5723.7 6423.5 6431.7 6489.2 6490.8 6563.5 4828.4 4832.2 4856.5 4860.2 4873.8 6832.8 6949.9 6983.7 6992.9 7008.1 4941.3 4944.4 4952.6 4971.8 5002.4 4928.0 5059.4 5064.4 5086.5 5089.1 5721.9 5724.7 5739.3 5752.5 5752.8 6469.9 6571.9 6581.9 6591.4 6592.6 1672.1 1688.8 1706.9 1744.1 1761.6 1192.7 1230.7 1235.4 1240.4 1243.2 5629.7 5752.3 5808.8 5815.6 5836.5 6516.7 6586.3 6690.1 6697.3 6726.6 5775.4 5776.7 5780.8 5873.4 5898.3 3547.4 3566.8 3567.7 3598.7 3643.8 6642.4 6664.1 6667.3 6688.0 6694.2 6924.8 6939.0 6950.9 7012.5 7016.9 6489.3 6559.5 6654.9 6672.4 6703.8 6638.2 6657.6 6660.2 6664.6 6726.2 6549.0 6563.4 6638.4 6747.7 6752.1 6469.9 6569.4 6605.7 6615.6 6651.2 4952.0 4980.9 5003.8 5010.8 5029.3 6623.5 6653.5 6740.6 6759.2 6763.5 6468.8 6474.2 6491.4 6502.5 6561.7 6479.0 6496.3 6501.6 6562.6 6608.2 6204.7 6298.2 6339.2 6372.8 6492.7 6368.8 6390.9 6444.7 6453.6 6464.4 6281.7 6320.9 6325.8 6387.3 6409.6 17:15:11 INFO - PID 17621 | 17:15:11 INFO - PID 17621 | [#5] yui.html Cycles:180 Average:22727.82 Median:19643.20 stddev:30897.28 (157.3%) stddev-sans-first:30940.35 17:15:11 INFO - PID 17621 | Values: 867.9 887.2 901.6 906.3 912.5 16912.0 17480.5 17532.9 17578.5 17597.3 20769.0 20983.1 21005.0 21040.4 21066.9 1049.1 1070.4 1074.1 1074.2 1074.5 970.9 1040.6 1055.9 1056.8 1062.6 1115.9 1121.4 1124.8 1125.9 1128.1 1103.2 1106.5 1107.9 1108.7 1109.3 809.3 810.7 813.1 813.4 814.9 17704.3 17916.4 18760.9 19075.0 19220.1 20127.4 20598.9 20881.4 20964.0 21024.7 16069.6 16413.0 16414.8 16460.4 16526.8 3482.6 3483.7 3499.5 3501.0 3511.2 119234.4 123558.0 124496.0 127955.0 130620.0 15072.5 15291.4 15312.2 15498.1 15500.8 29921.3 30272.8 30304.8 30337.0 30349.4 7969.6 7985.6 8034.5 8037.3 8061.0 3836.9 3921.0 3932.9 3933.7 3935.0 4854.3 5015.1 5512.6 5690.9 5736.1 1031.5 1055.6 1068.8 1070.4 1072.3 618.6 620.4 639.1 651.9 674.4 11356.3 13127.1 13292.5 13370.0 13410.5 621.2 625.2 644.5 645.7 665.2 5262.5 5271.6 5373.5 5390.7 5494.8 98967.5 102585.5 104891.0 105678.0 106393.5 91395.0 94361.0 94841.5 95375.0 101782.5 88460.6 88682.6 88833.6 90014.1 95811.0 11633.0 11661.4 11893.9 12457.4 12498.3 34369.7 36424.8 36990.8 37320.8 37746.4 44090.6 45027.8 45394.0 46700.5 48126.5 17490.3 17774.6 17945.8 18361.2 18537.3 16929.5 19868.1 19929.0 19943.9 21280.0 18160.5 18710.4 19132.4 19857.0 20183.9 19153.7 19398.6 19447.9 19838.5 19932.7 17312.7 17372.9 17722.7 17859.8 18113.2 12473.3 13426.3 13580.4 13803.8 14186.3 13820.2 14320.6 14357.7 14616.8 14702.8 17:15:11 INFO - PID 17621 | -------- Summary: end -------- 17:15:11 INFO - PID 17621 | 17:15:12 INFO - TEST-INFO | 17621: exit 0 17:15:12 INFO - TEST-OK | dromaeo_css | took 1113277ms 17:15:12 INFO - TEST-START | kraken 17:15:12 INFO - Initialising browser for kraken test... 17:15:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37672/getInfo.html -profile /tmp/tmpNPW1GI/profile 17:15:12 INFO - TEST-INFO | started process 17993 (/builds/slave/test/build/application/firefox/firefox http://localhost:37672/getInfo.html) 17:15:17 INFO - TEST-INFO | 17993: exit 0 17:15:17 INFO - Browser initialized. 17:15:17 INFO - Running cycle 1/1 for kraken test... 17:15:17 INFO - TEST-INFO | started process 18220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNPW1GI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:18 INFO - PID 18220 | 17:15:18 INFO - PID 18220 | (/builds/slave/test/build/application/firefox/firefox:18274): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:18 INFO - PID 18220 | 17:15:29 INFO - PID 18220 | RSS: Main: 173469696 17:15:29 INFO - PID 18220 | 17:15:31 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37672/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:32 INFO - PID 18220 | RSS: Main: 178671616 17:15:32 INFO - PID 18220 | 17:15:35 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37672/tests/kraken/driver.html?testName=audio-dft) 17:15:36 INFO - PID 18220 | RSS: Main: 178614272 17:15:36 INFO - PID 18220 | 17:15:39 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37672/tests/kraken/driver.html?testName=audio-fft) 17:15:39 INFO - PID 18220 | RSS: Main: 173633536 17:15:39 INFO - PID 18220 | 17:15:42 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37672/tests/kraken/driver.html?testName=audio-oscillator) 17:15:42 INFO - PID 18220 | RSS: Main: 174333952 17:15:42 INFO - PID 18220 | 17:15:45 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:45 INFO - PID 18220 | RSS: Main: 174325760 17:15:45 INFO - PID 18220 | 17:15:48 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37672/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:49 INFO - PID 18220 | RSS: Main: 177430528 17:15:49 INFO - PID 18220 | 17:15:53 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37672/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:53 INFO - PID 18220 | RSS: Main: 176828416 17:15:53 INFO - PID 18220 | 17:15:56 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37672/tests/kraken/driver.html?testName=json-parse-financial) 17:15:57 INFO - PID 18220 | RSS: Main: 177455104 17:15:57 INFO - PID 18220 | 17:15:58 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:59 INFO - PID 18220 | RSS: Main: 177635328 17:15:59 INFO - PID 18220 | 17:16:01 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:02 INFO - PID 18220 | RSS: Main: 174620672 17:16:02 INFO - PID 18220 | 17:16:04 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:04 INFO - PID 18220 | RSS: Main: 174198784 17:16:04 INFO - PID 18220 | 17:16:07 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:08 INFO - PID 18220 | RSS: Main: 175284224 17:16:08 INFO - PID 18220 | 17:16:11 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:12 INFO - PID 18220 | RSS: Main: 175390720 17:16:12 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | Cycle 1(1): loaded http://localhost:37672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37672/tests/kraken/driver.html?testName=ai-astar) 17:16:14 INFO - PID 18220 | RSS: Main: 176922624 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | __start_tp_report 17:16:14 INFO - PID 18220 | _x_x_mozilla_page_load 17:16:14 INFO - PID 18220 | _x_x_mozilla_page_load_details 17:16:14 INFO - PID 18220 | |i|pagename|runs| 17:16:14 INFO - PID 18220 | |0;ai-astar;110;110;112;110;114;111;110;100;108;109 17:16:14 INFO - PID 18220 | |1;audio-beat-detection;152;119;146;177;119;156;148;121;172;133 17:16:14 INFO - PID 18220 | |2;audio-dft;163;162;164;162;167;172;171;161;166;165 17:16:14 INFO - PID 18220 | |3;audio-fft;76;81;84;195;76;78;76;74;150;77 17:16:14 INFO - PID 18220 | |4;audio-oscillator;83;78;131;81;77;79;125;79;79;124 17:16:14 INFO - PID 18220 | |5;imaging-gaussian-blur;114;121;117;113;113;114;113;127;118;116 17:16:14 INFO - PID 18220 | |6;imaging-darkroom;152;150;150;150;151;152;153;157;155;152 17:16:14 INFO - PID 18220 | |7;imaging-desaturate;93;98;93;94;95;99;94;93;94;94 17:16:14 INFO - PID 18220 | |8;json-parse-financial;56;56;57;62;55;56;56;55;61;56 17:16:14 INFO - PID 18220 | |9;json-stringify-tinderbox;54;54;56;55;54;56;56;54;56;55 17:16:14 INFO - PID 18220 | |10;stanford-crypto-aes;89;80;87;83;82;80;81;79;85;81 17:16:14 INFO - PID 18220 | |11;stanford-crypto-ccm;130;131;128;127;135;125;134;127;126;171 17:16:14 INFO - PID 18220 | |12;stanford-crypto-pbkdf2;187;183;182;176;181;174;177;187;192;183 17:16:14 INFO - PID 18220 | |13;stanford-crypto-sha256-iterative;79;70;69;72;70;68;72;70;72;70 17:16:14 INFO - PID 18220 | __end_tp_report 17:16:14 INFO - PID 18220 | __start_cc_report 17:16:14 INFO - PID 18220 | _x_x_mozilla_cycle_collect,948 17:16:14 INFO - PID 18220 | __end_cc_report 17:16:14 INFO - PID 18220 | __startTimestamp1501200974300__endTimestamp 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | ------- Summary: start ------- 17:16:14 INFO - PID 18220 | Number of tests: 14 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.69 (3.4%) stddev-sans-first:3.91 17:16:14 INFO - PID 18220 | Values: 110.0 110.0 112.0 110.0 114.0 111.0 110.0 100.0 108.0 109.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:21.08 (14.1%) stddev-sans-first:22.18 17:16:14 INFO - PID 18220 | Values: 152.0 119.0 146.0 177.0 119.0 156.0 148.0 121.0 172.0 133.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:3.77 (2.3%) stddev-sans-first:3.91 17:16:14 INFO - PID 18220 | Values: 163.0 162.0 164.0 162.0 167.0 172.0 171.0 161.0 166.0 165.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#3] audio-fft Cycles:10 Average:96.70 Median:76.50 stddev:41.43 (54.2%) stddev-sans-first:43.26 17:16:14 INFO - PID 18220 | Values: 76.0 81.0 84.0 195.0 76.0 78.0 76.0 74.0 150.0 77.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:22.95 (29.0%) stddev-sans-first:24.01 17:16:14 INFO - PID 18220 | Values: 83.0 78.0 131.0 81.0 77.0 79.0 125.0 79.0 79.0 124.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:116.50 stddev:4.50 (3.9%) stddev-sans-first:4.68 17:16:14 INFO - PID 18220 | Values: 114.0 121.0 117.0 113.0 113.0 114.0 113.0 127.0 118.0 116.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.00 stddev:2.30 (1.5%) stddev-sans-first:2.44 17:16:14 INFO - PID 18220 | Values: 152.0 150.0 150.0 150.0 151.0 152.0 153.0 157.0 155.0 152.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:2.11 (2.2%) stddev-sans-first:2.15 17:16:14 INFO - PID 18220 | Values: 93.0 98.0 93.0 94.0 95.0 99.0 94.0 93.0 94.0 94.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:2.45 (4.4%) stddev-sans-first:2.57 17:16:14 INFO - PID 18220 | Values: 56.0 56.0 57.0 62.0 55.0 56.0 56.0 55.0 61.0 56.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.50 stddev:0.94 (1.7%) stddev-sans-first:0.93 17:16:14 INFO - PID 18220 | Values: 54.0 54.0 56.0 55.0 54.0 56.0 56.0 54.0 56.0 55.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.30 (4.0%) stddev-sans-first:2.60 17:16:14 INFO - PID 18220 | Values: 89.0 80.0 87.0 83.0 82.0 80.0 81.0 79.0 85.0 81.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:130.50 stddev:13.62 (10.4%) stddev-sans-first:14.39 17:16:14 INFO - PID 18220 | Values: 130.0 131.0 128.0 127.0 135.0 125.0 134.0 127.0 126.0 171.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:183.00 stddev:5.55 (3.0%) stddev-sans-first:5.61 17:16:14 INFO - PID 18220 | Values: 187.0 183.0 182.0 176.0 181.0 174.0 177.0 187.0 192.0 183.0 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:3.05 (4.3%) stddev-sans-first:1.41 17:16:14 INFO - PID 18220 | Values: 79.0 70.0 69.0 72.0 70.0 68.0 72.0 70.0 72.0 70.0 17:16:14 INFO - PID 18220 | -------- Summary: end -------- 17:16:14 INFO - PID 18220 | 17:16:14 INFO - PID 18220 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:16:14 INFO - TEST-INFO | 18220: exit 0 17:16:15 INFO - TEST-OK | kraken | took 62699ms 17:16:15 INFO - SUITE-END | took 1175s 17:16:15 INFO - Completed test suite (00:19:36) 17:16:15 INFO - javascript benchmark 17:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8466.026415654256, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.8734050637963, 3187.6015498062748, 3210.357928414316, 3224.6291676457186, 3252.3657886712085, 6089.45194932456, 6122.969385153074, 6153.138560601519, 6181.28915174755, 6245.032020036891, 6083.665398403086, 6240.3759624037575, 6289.025201093827, 6297.023961285997, 6326.304106548288, 5649.717514124277, 5665.1785491103765, 5758.309002919645, 5787.826365209051, 5793.420657934215, 5649.717514124298, 5717.342505611846, 5739.827805165852, 5748.48263656273, 5805.12923061542, 5565.526930210916, 5612.354579223401, 5643.238162848024, 5694.032014557493, 5711.200431939553, 5584.748686309126, 5628.605997580171, 5651.604387692863, 5658.603897727161, 5667.943320566783, 5502.119660854244, 5558.610897237195, 5639.379668236532, 5643.8589035274035, 5646.661200327952, 6040.758369665208, 6046.818595442144, 6087.756489740405, 6110.480609148228, 6128.509719222451, 6686.83282917926, 6696.430803381719, 6700.765473208463, 6704.7988560343265, 6719.428848547879, 6762.087118239024, 6772.627505487246, 6775.356341147583, 6775.4918381121615, 6782.186137663462, 6169.629822210682, 6206.937930620727, 6231.6572588507615, 6240.4071613196675, 6264.812055638338, 6844.452443804484, 6897.103376561015, 6960.79117626472, 6989.720411183495, 6995.440364770806, 6439.967800160969, 6467.644279564575, 6558.475321974231, 6564.409203171737, 6581.3418658133805, 6716.46268298535, 6720.294369091175, 6732.427743641845, 6739.730410783612, 6760.019797129388, 6686.966565167143, 6701.262861085277, 6764.425023872927, 6770.4922130839395, 6777.932220677829, 6693.397594216543, 6710.328967103348, 6782.660866956731, 6783.321667833177, 6818.0, 5387.676739395649, 5436.21174929633, 5456.7544460499375, 5519.530839878575, 5545.195946587723, 4667.836625718083, 4685.0629874025335, 4700.670953033255, 4729.881752956135, 4765.26138448541, 5895.027320492157, 5908.14331921869, 5912.408759124053, 5915.112733089984, 5928.911066334009, 6710.429613482908, 6725.630090345078, 6809.489288303397, 6814.114165158498, 6848.7260509580055, 5838.474537291664, 5858.619189752738, 5916.852078698067, 5939.287285525765, 5941.7623295067715, 5891.911621325684, 5951.464368206882, 5982.042873140364, 5997.820065398045, 6035.064564992434, 6393.104965304954, 6510.674466276667, 6544.443722283564, 6547.869042619121, 6551.115599394021, 6689.866202675822, 6776.0, 6781.355771201728, 6786.355296246848, 6793.116894803644, 6522.315156908457, 6527.445167160845, 6561.311062338576, 6564.310747371457, 6564.573302735307, 6570.901436478553, 6612.636305003079, 6696.732130714717, 6697.799066028027, 6703.430208432338, 6619.172603424572, 6734.932650673627, 6749.5612785168805, 6751.088603038724, 6829.453643708591, 6441.71012304438, 6451.677416129269, 6468.514861385321, 6475.3200913903365, 6494.188226471691, 6350.142730731477, 6447.129637498878, 6453.9354606453335, 6463.15978922737, 6465.741370345134, 5459.7270136492225, 6295.433410993032, 6390.7763228286785, 6391.872162556816, 6555.147830781968, 6507.642079685663, 6519.934800651933, 6561.442277406283, 6615.106960560262, 6624.966875165594, 6223.657698826427, 6292.968535157295, 6329.683515824098, 6361.363863613787, 6364.172657554488], "value": 6109.97616883768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.460633285198, 871.4945331707609, 898.8157427727313, 899.2446345070142, 1162.2968104296895, 31038.224044398903, 31552.684473155292, 41757.37363939543, 41965.0, 42042.948926276855, 42941.570584294146, 43413.131737365235, 43419.565804341946, 43420.3486947696, 43529.34705979413, 7745.7676269712, 7760.650770715303, 7903.48627339224, 7976.641051152683, 7994.760157195265, 7817.5309481431295, 7909.841803163933, 7910.762677119696, 7912.881306780403, 7942.841143177162, 7927.4847134936335, 7930.682772689085, 7933.0876949150725, 7962.0, 7991.240832120969, 7885.881711774328, 7896.249856263646, 7930.325922296583, 7939.325157361631, 7947.125816160218, 7793.571353575551, 7806.804829879242, 7861.174576669425, 7863.960680196562, 7881.763547093597, 38871.222575548614, 39184.60815391838, 39241.0, 39272.41091383631, 39283.41074883879, 3414.5048967899515, 3457.343104810078, 3480.1995541025453, 3481.1819222482695, 3485.4597537381746, 31297.217569560715, 31362.52956205659, 31382.52926206109, 31436.371272574648, 31512.0, 4713.6936099153445, 4829.758512074382, 4864.537868902448, 4885.706857588556, 4906.803727850882, 186670.0, 187276.0, 188383.0, 188635.0, 189039.05480472647, 49419.75290123526, 49490.010199796525, 49538.50461495411, 49630.25554616684, 49704.0, 51740.22389664158, 51777.0, 51934.740326298124, 52124.21813672798, 52135.21797173045, 14909.70180596382, 16593.087380193963, 16859.747103793452, 16925.576860578585, 16941.576460588585, 12574.43415046325, 12577.622671319876, 12588.937055314847, 13861.445542178402, 14015.719685606231, 14762.335694893542, 14838.554843354717, 14849.480268190777, 14937.0, 14972.1016738996, 5745.741441635137, 5749.084532724544, 5881.206037185011, 6022.488088512438, 6050.909236361458, 958.2382006305004, 970.5438443931341, 985.4776968206862, 1013.1287093099928, 1029.6653587584065, 28532.0, 28939.276518087216, 29002.564961525593, 29331.0, 29946.0, 1061.808874402615, 1082.4587706146926, 1092.5356723392526, 1093.2292733622776, 1106.6016234155697, 12106.576269830513, 12434.564790232298, 12650.493980240688, 12691.555795547112, 16162.434314798926, 222440.0, 222775.0, 222852.0, 223254.0, 223987.0, 61744.691276544225, 62074.689626551575, 62176.067358989654, 62183.06725399123, 62745.68627156835, 1500.2648702135875, 1524.8932574719886, 1547.3501129525625, 1552.0765144738862, 1558.9220538973007, 27234.0, 28040.57939130874, 28216.29459263535, 28227.858860705564, 28371.57442638321, 38756.6124338753, 39073.2185356297, 39194.608053919095, 39428.2114357717, 39501.40747888727, 189221.0, 189683.0, 190150.19699605653, 190473.0, 191007.0, 32156.51765223477, 32570.0, 32609.18477038093, 34808.0, 35820.0, 44402.55597443984, 44802.55197447984, 44807.77596111999, 45016.32475512935, 45739.77130114328, 29605.85197074001, 29989.70010299869, 31974.840125799223, 32019.6798032026, 32105.678943211202, 30089.548656770603, 31549.0, 31577.0, 31643.0, 31772.364552708354, 35269.0, 36070.0, 36108.458373123896, 36199.45700814542, 36443.63556364403, 31161.532577011818, 31576.368472629958, 32048.67951320457, 32139.67860321367, 32173.67826321707, 23307.18424855122, 23621.0, 23628.375642890565, 23875.761242387354, 24045.158419455936], "value": 17573.622663404796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9142128680697, 577.7082573300482, 577.80354679409, 582.36522190812, 582.7581553655233, 22096.668549971724, 22256.443588910264, 23027.194048208316, 23079.884600576996, 23121.537569248627, 25806.35484112898, 26212.737872621266, 26326.210213693572, 26374.0, 26408.339791505223, 6509.121268628734, 6641.435477984377, 6671.266160722316, 6682.0, 6694.73221071159, 6013.488853447462, 6577.309382514839, 6578.177727784027, 6649.833754156137, 6670.899936500957, 6520.347965203489, 6535.673216339188, 6536.640484773336, 6545.280019197909, 6555.213374395055, 6542.41118299353, 6544.3782840630065, 6547.47620190386, 6551.279359270524, 6564.5404821662505, 6060.666663333515, 6077.939220607782, 6103.511719062509, 6112.144299798032, 6112.694365281718, 28412.857935710188, 28875.0, 29296.267593310124, 29423.2644183895, 29853.850730746424, 1831.38648552735, 1890.5179179309325, 1890.8203720646516, 1891.1111777464569, 1891.8013608571039, 19070.80929190704, 19305.03474826253, 19307.613847722965, 19360.225590976344, 19387.224511019544, 2258.3450799268194, 2363.2555744940287, 2402.1952645863657, 2405.20628192696, 2406.9879650601633, 124992.0, 127083.36458317742, 127554.36222818919, 127922.36038819839, 127985.99999999907, 14352.784708229385, 14682.486112986207, 14968.101913885203, 15231.562949927958, 15234.162121083225, 22591.774082259297, 22601.88699056494, 22739.0, 22745.203917862797, 22780.43048923757, 10225.948870255601, 10529.894701053045, 10668.413237271869, 10719.19606029551, 10857.45712714361, 9942.602295908227, 9985.45080020606, 10076.29465937392, 10200.846987295197, 10219.386836789816, 7741.380689544823, 8958.596863141174, 9121.908780912107, 9289.071092890792, 9323.580438880266, 2596.415806443573, 2611.9496195486454, 2655.7650692428115, 2770.48745981994, 2831.0940499040107, 936.9340996771891, 967.5307475874196, 967.7919247361851, 984.158544444504, 988.8813342398959, 19153.52116197106, 19266.71099933502, 22308.665370019462, 23031.0, 23845.880770596035, 1021.2085633633993, 1021.2493817044466, 1030.5877648940484, 1064.797688439194, 1070.5931745936493, 10667.83998240027, 11086.833697494543, 11109.722256943642, 11132.777344453065, 11150.832737508943, 467579.0, 472150.0, 484225.0, 485005.0, 506582.0, 118287.40856295664, 118811.40594296974, 119335.0, 119598.0, 122465.0, 1225.6997035726126, 1283.3454937981696, 1315.7500074985915, 1320.7160460501038, 1321.7026169112064, 20139.899300503403, 20413.183472660927, 20734.27430040002, 20982.37052888416, 21379.46551336229, 57098.714506427204, 59142.70428647829, 59840.70079649574, 60739.39260607337, 62079.06881396873, 74896.2510374911, 75241.0, 75642.62178689071, 75825.6208718975, 76053.23946760461, 12602.684932876384, 13030.47878084866, 14365.20991345486, 14891.40434382656, 14895.92552037233, 23414.88292558526, 24168.395790105387, 24227.636585451586, 24398.146064887645, 24905.87547062253, 18655.253789848255, 18697.0, 18740.156692949124, 18943.147558360182, 18971.33600323982, 15817.920910395374, 16063.839361606702, 16197.0, 16373.0, 16915.492535223962, 18028.81971180324, 18141.546461338574, 18218.90890545592, 18380.264789408273, 18700.81299186991, 13909.51316703951, 14018.859811401755, 14027.579172624837, 14149.858501415265, 14187.432502700189, 18884.527886802938, 18885.43343699691, 19048.0, 19120.52198694988, 19239.903800480908], "value": 12084.032944157807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.9667758306043, 1375.6010756880505, 1392.4778208171936, 1396.7416028034809, 1412.3573773932858, 13632.522861699843, 13909.93045034776, 14036.298185090744, 14043.859561404382, 14094.0, 14260.429582816674, 14584.562463126096, 14588.708225835477, 14599.197044162567, 14621.268936553157, 2653.150991682662, 2686.7044625091225, 2689.973100268992, 2692.219256415637, 2692.609571612115, 2592.338953566838, 2641.3264617522505, 2645.9470810583775, 2679.1025006622804, 2680.530907091261, 2731.576605626131, 2765.0737003103986, 2771.5565509518483, 2778.2776478115634, 2778.7360200780995, 2592.5722255827764, 2615.555355589545, 2630.2240838952557, 2631.999840060774, 2683.154806236049, 2632.7893768498475, 2641.3660721426913, 2644.1274379454926, 2660.8536530490815, 2674.0, 13745.450181992708, 13858.514951976633, 13884.930575347058, 13895.305234738222, 13922.0, 7425.702971881118, 7604.391648668094, 7651.846963060708, 7655.50239234448, 7679.232076792332, 5001.624878134118, 5015.799368025275, 5109.6678715883345, 5193.480651934814, 5264.736763161826, 1829.4968883556994, 1845.769278840145, 1858.2845604442252, 1873.4286042756953, 1883.4443839067508, 22554.774452255595, 22752.65871011936, 22758.54482910349, 22797.658035129487, 22879.31362059124, 6342.4926005919415, 6474.870502589922, 6613.735450581923, 6649.667516624149, 6698.39714425704, 15588.922055389878, 15654.139022353653, 15673.84326156724, 15675.686486270211, 15702.607434814221, 7186.245444228385, 7497.437692173109, 7545.320921117016, 7604.505707129129, 7623.847523049619, 6904.275051119661, 7047.823804404931, 7109.644517774091, 7113.359797618135, 7113.75101871432, 5061.468545802712, 5089.592832573385, 5174.146265866165, 5198.9740051299505, 5201.609879258995, 1413.5264686329988, 1416.9291535423395, 1503.090630168754, 1520.4070412539118, 1546.621077835915, 830.5307501261889, 839.6851180807197, 850.141357229203, 855.4909828651943, 855.623525648725, 7420.738474459355, 7632.122305934889, 7637.15991240963, 7658.119316278699, 7678.616069196518, 944.6929747831982, 946.2524605561667, 991.0683957080322, 994.1301361308855, 1005.0100650859044, 4583.427071616048, 4680.81276748933, 4781.808727650925, 4807.543283388072, 4912.680675756064, 18228.908855455637, 18615.813841861407, 18800.059997000095, 19076.2369505221, 19173.90413047926, 18997.81002189988, 19027.524311892037, 19078.427647170607, 19265.325713599956, 19272.518187045156, 10058.446785426871, 10539.367637941748, 10557.419341936267, 10565.366078035342, 10579.471026448648, 7191.20896701352, 7545.886811697719, 7578.204288549623, 7726.111497177896, 7762.223777622193, 16011.199440028186, 16465.670686585963, 16607.50177494677, 16800.159992000594, 17042.403515876886, 16621.667566648357, 16916.57708557296, 16984.57538561546, 17166.828331716522, 17337.13314334253, 11033.117350611772, 11202.38386888729, 11207.551697931991, 11210.327380357205, 11240.15698822608, 12311.815322769986, 12543.372831358578, 12584.748305033665, 12611.43248553799, 12618.432170552163, 10036.19710423179, 10382.636607718996, 10468.738281543023, 10560.0, 10696.14430845515, 9574.138327550554, 10035.949820250851, 10173.389596624227, 10179.541920613443, 10238.0, 8833.779155521164, 8912.910870891208, 8933.374663773473, 8960.327975402, 8962.0, 6164.137020816999, 6210.596311239755, 6518.0, 6620.900686489803, 6663.233728121328, 7118.822029449305, 7159.319864612853, 7162.2121566628675, 7167.462440317101, 7223.205447400886], "value": 6276.854234155635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.4929489188345, 501.1963724804789, 513.0687801640023, 516.3700285651504, 523.202116771923, 6237.035333869828, 6284.08880712297, 6301.4013668701455, 6339.651319177444, 6352.5235607329405, 5903.586748927566, 6095.146679464879, 6101.725422355994, 6141.556734167467, 6213.161223234862, 4876.244182151772, 4959.528844759742, 4967.155583550796, 4968.155413579682, 5013.3232013678235, 4847.781849816749, 4872.585830204437, 4921.704697718131, 4941.4811444798315, 4974.179260422026, 4719.221328480814, 4849.5877850382585, 4878.951210487885, 4889.33993910821, 4927.6550641455115, 4890.339804126433, 4928.186849169901, 4939.431965323998, 4940.073371385162, 4976.87557811054, 4357.0, 4368.584984426474, 4394.934075988863, 4400.44994375703, 4425.845095421645, 5978.40215978403, 6012.609180403259, 6020.939790602081, 6029.577929544934, 6035.547333949928, 5677.829665110054, 5685.2091591148655, 5717.371089180187, 5721.942780572224, 5723.656580605136, 6423.518236132309, 6431.742730290783, 6489.1888513935755, 6490.772822951221, 6563.50773691975, 4828.444728856191, 4832.154372984749, 4856.538628830291, 4860.1737704590305, 4873.805047798084, 6832.795016149524, 6949.89575156373, 6983.685734141975, 6992.860142797217, 7008.123984501988, 4941.332920055818, 4944.381952255968, 4952.554270115635, 4971.751412429364, 5002.399712034579, 4927.965127323302, 5059.392872855281, 5064.417591976896, 5086.465921078234, 5089.134847075932, 5721.885562288731, 5724.685142317129, 5739.278216535106, 5752.453516915886, 5752.791913698086, 6469.902951455732, 6571.929842099723, 6581.901271480931, 6591.373819487141, 6592.604443733391, 1672.1304921440783, 1688.7804585404065, 1706.9146542672818, 1744.1366523570914, 1761.5596100974756, 1192.6940000699221, 1230.6677197156896, 1235.3576140406938, 1240.4232032105115, 1243.154654834721, 5629.662220266797, 5752.33848107473, 5808.767649293981, 5815.592908496449, 5836.503897168704, 6516.739330426824, 6586.341365863471, 6690.130283063268, 6697.330266973361, 6726.596404215763, 5775.393583673737, 5776.7111644418455, 5780.797672081457, 5873.442023007808, 5898.292204935349, 3547.396942519778, 3566.821658917044, 3567.661072198137, 3598.7480876338404, 3643.8178091095338, 6642.402183803384, 6664.133662623828, 6667.266600673922, 6687.966560167168, 6694.196696396463, 6924.849193616892, 6938.965305173442, 6950.895736563955, 7012.474064445187, 7016.859662806715, 6489.253735820441, 6559.5408321418, 6654.866902661823, 6672.432843208382, 6703.765368212089, 6638.236602790547, 6657.633830139195, 6660.200775906922, 6664.566803157779, 6726.192856857208, 6548.967255163694, 6563.409293163638, 6638.402543771083, 6747.730090796314, 6752.122224110834, 6469.935300646934, 6569.408753212234, 6605.702743376656, 6615.636140012345, 6651.235107962646, 4951.9752401237765, 4980.850574482772, 5003.77483013258, 5010.799568017384, 5029.321041659329, 6623.536352455475, 6653.467722582279, 6740.595564266159, 6759.208809665541, 6763.49750592284, 6468.8059358219325, 6474.223093228843, 6491.4482269005775, 6502.479801615954, 6561.671916404256, 6478.967605162133, 6496.252930913006, 6501.577397469338, 6562.639054852029, 6608.173978252718, 6204.658743769136, 6298.244210694746, 6339.175907132043, 6372.840678983062, 6492.707828147651, 6368.758616555709, 6390.872182556416, 6444.677766111582, 6453.612783233021, 6464.385883341075, 6281.654509002049, 6320.873582528232, 6325.810225693236, 6387.329330420424, 6409.647469389229], "value": 5042.604805400555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.8611422172454, 887.2414085956507, 901.6213190460006, 906.274980015987, 912.4662072687478, 16912.0, 17480.47558573243, 17532.912335438337, 17578.472645820646, 17597.296108155657, 20769.0, 20983.055762490723, 21005.0, 21040.368788936317, 21066.89466552669, 1049.1344640671457, 1070.3524367757511, 1074.1192222377654, 1074.248026381532, 1074.5433190893839, 970.9465979371132, 1040.5889673578931, 1055.9313644613114, 1056.8309070548714, 1062.5537274344756, 1115.8884111588857, 1121.4336759936261, 1124.7525544380223, 1125.926814757038, 1128.05807151029, 1103.1560855945208, 1106.5241945963232, 1107.9446027698664, 1108.6507750058706, 1109.295597295719, 809.2676128104075, 810.6676262732251, 813.1258896686027, 813.4102775487784, 814.8533264012475, 17704.291828326852, 17916.372926947493, 18760.906195468935, 19075.0, 19220.135093920668, 20127.396178114534, 20598.897005515028, 20881.37355879326, 20964.0, 21024.684629730567, 16069.598260043476, 16413.0, 16414.83585164157, 16460.42388516408, 16526.83473165277, 3482.564679415073, 3483.721302295836, 3499.5450591423205, 3501.037214765934, 3511.2099777549847, 119234.4038279803, 123558.0, 124496.0, 127955.0, 130620.0, 15072.54782356531, 15291.388344466319, 15312.157831319384, 15498.147601882005, 15500.767488487681, 29921.251968700522, 30272.84863575668, 30304.84847575748, 30337.0, 30349.393012140074, 7969.561674107864, 7985.600719963979, 8034.517928924283, 8037.316828069563, 8060.959695201486, 3836.9424458633143, 3920.9607903920596, 3932.9213415731524, 3933.7049721270446, 3934.9803250983564, 4854.296127061627, 5015.14742493777, 5512.641678290898, 5690.9146362804595, 5736.110902810071, 1031.5461197073264, 1055.5988724284723, 1068.8396740488988, 1070.4059247117925, 1072.340510585984, 618.6288227063816, 620.3889169168456, 639.1212083385345, 651.8794023105646, 674.4098913450731, 11356.26184298018, 13127.146735462164, 13292.468301267842, 13370.0, 13410.530631428048, 621.2482895696168, 625.2434554189482, 644.4779728419995, 645.6674812471581, 665.1685393258427, 5262.473752624707, 5271.604629652791, 5373.516383525502, 5390.730463476811, 5494.780208791683, 98967.50516247372, 102585.48707256417, 104891.0, 105678.0, 106393.46803265934, 91395.0, 94361.0, 94841.5257923706, 95375.0, 101782.49108754408, 88460.5576972111, 88682.55658721794, 88833.55583222171, 90014.09985900189, 95811.0, 11633.0111940486, 11661.416929153338, 11893.937532253569, 12457.377131143225, 12498.25010499373, 34369.656303437645, 36424.81787591045, 36990.815045924595, 37320.81339593285, 37746.43380349242, 44090.55909440993, 45027.77486112549, 45394.0, 46700.532994670975, 48126.5187348136, 17490.300387984847, 17774.644507110042, 17945.820541794415, 18361.173747181143, 18537.258509659463, 16929.49211523607, 19868.10593523266, 19929.0, 19943.900280498503, 21280.042398091813, 18160.545986350447, 18710.438686839418, 19132.426027219204, 19857.0, 20183.899080504503, 19153.712694309317, 19398.61202775908, 19447.902760486108, 19838.50403739918, 19932.70100948516, 17312.740308895627, 17372.934260928647, 17722.734158987885, 17859.83911045778, 18113.18490667897, 12473.251604903735, 13426.261555614536, 13580.388882500114, 13803.79294310566, 14186.290685465892, 13820.23988680592, 14320.57038288853, 14357.712845743235, 14616.780748288571, 14702.779458308349], "value": 8964.794342276207, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 110.0, 114.0, 111.0, 110.0, 100.0, 108.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 146.0, 177.0, 119.0, 156.0, 148.0, 121.0, 172.0, 133.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 162.0, 167.0, 172.0, 171.0, 161.0, 166.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 84.0, 195.0, 76.0, 78.0, 76.0, 74.0, 150.0, 77.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 131.0, 81.0, 77.0, 79.0, 125.0, 79.0, 79.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 117.0, 113.0, 113.0, 114.0, 113.0, 127.0, 118.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 150.0, 151.0, 152.0, 153.0, 157.0, 155.0, 152.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 98.0, 93.0, 94.0, 95.0, 99.0, 94.0, 93.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 62.0, 55.0, 56.0, 56.0, 55.0, 61.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 54.0, 56.0, 56.0, 54.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 87.0, 83.0, 82.0, 80.0, 81.0, 79.0, 85.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 128.0, 127.0, 135.0, 125.0, 134.0, 127.0, 126.0, 171.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 182.0, 176.0, 181.0, 174.0, 177.0, 187.0, 192.0, 183.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 70.0, 69.0, 72.0, 70.0, 68.0, 72.0, 70.0, 72.0, 70.0], "value": 71.2, "unit": "score"}]}]} 17:16:15 INFO - Return code: 0 17:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:15 INFO - # TBPL SUCCESS # 17:16:15 INFO - Running post-action listener: _package_coverage_data 17:16:15 INFO - Running post-action listener: _resource_record_post_action 17:16:15 INFO - [mozharness: 2017-07-28 00:16:15.588600Z] Finished run-tests step (success) 17:16:15 INFO - Running post-run listener: _resource_record_post_run 17:16:15 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431538176; Read time: 16; Write time: 316948 17:16:15 INFO - TinderboxPrint: CPU usage
13.1% 17:16:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:16:15 INFO - TinderboxPrint: I/O write bytes / time
431,538,176 / 316,948 17:16:15 INFO - TinderboxPrint: CPU idle
8,274.7 (86.8%) 17:16:15 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 17:16:15 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107753472; Read time: 0; Write time: 99140 17:16:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:16:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 323784704; Read time: 0; Write time: 217808 17:16:16 INFO - Running post-run listener: _upload_blobber_files 17:16:16 INFO - Blob upload gear active. 17:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:16 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 17:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:17 INFO - (blobuploader) - INFO - Done attempting. 17:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:21 INFO - (blobuploader) - INFO - Done attempting. 17:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:22 INFO - (blobuploader) - INFO - Done attempting. 17:16:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:23 INFO - (blobuploader) - INFO - Done attempting. 17:16:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:23 INFO - Return code: 0 17:16:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1208b50995551685705479c5974d3c17cdbe120692d86709653a4e4ce62fc1c239093f67db37cdbceba7a64890f3e2bac5e6b8f626e5f77425d7385e6e9a943", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01413c0a6fe957db6790b2ed491e1729708469fe3a14be4ddf2d7efd1d1dd66a9b0814f55a35f504b28e97fc7b97f840202e036ee7927787a9bdfc9c6a8326cf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1379b14794c860268f2fbb5c9fdde8323d1178e92f4205ba06b30a4806c6b00e516052ffcb3d17e8ba2ad1601c0caeeea47490f380468bb6bec513700988915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4df9b4dd5f46d9f0e39b51b76ffcc8330ac623f77ba369bfcdb033d81a5cadcb24b7cbb2d4383d04d03e01900b5ee142b936163f9e88f6673f036f18eabcbb"} 17:16:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:23 INFO - Contents: 17:16:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1208b50995551685705479c5974d3c17cdbe120692d86709653a4e4ce62fc1c239093f67db37cdbceba7a64890f3e2bac5e6b8f626e5f77425d7385e6e9a943", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01413c0a6fe957db6790b2ed491e1729708469fe3a14be4ddf2d7efd1d1dd66a9b0814f55a35f504b28e97fc7b97f840202e036ee7927787a9bdfc9c6a8326cf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1379b14794c860268f2fbb5c9fdde8323d1178e92f4205ba06b30a4806c6b00e516052ffcb3d17e8ba2ad1601c0caeeea47490f380468bb6bec513700988915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4df9b4dd5f46d9f0e39b51b76ffcc8330ac623f77ba369bfcdb033d81a5cadcb24b7cbb2d4383d04d03e01900b5ee142b936163f9e88f6673f036f18eabcbb"} 17:16:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:23 INFO - Copying logs to upload dir... 17:16:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.327095 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 17:16:22.861907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 17:16:22.867648) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1208b50995551685705479c5974d3c17cdbe120692d86709653a4e4ce62fc1c239093f67db37cdbceba7a64890f3e2bac5e6b8f626e5f77425d7385e6e9a943", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01413c0a6fe957db6790b2ed491e1729708469fe3a14be4ddf2d7efd1d1dd66a9b0814f55a35f504b28e97fc7b97f840202e036ee7927787a9bdfc9c6a8326cf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1379b14794c860268f2fbb5c9fdde8323d1178e92f4205ba06b30a4806c6b00e516052ffcb3d17e8ba2ad1601c0caeeea47490f380468bb6bec513700988915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4df9b4dd5f46d9f0e39b51b76ffcc8330ac623f77ba369bfcdb033d81a5cadcb24b7cbb2d4383d04d03e01900b5ee142b936163f9e88f6673f036f18eabcbb"} build_url:https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/M4-l_DlIR0urDflX_RShmA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1208b50995551685705479c5974d3c17cdbe120692d86709653a4e4ce62fc1c239093f67db37cdbceba7a64890f3e2bac5e6b8f626e5f77425d7385e6e9a943", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01413c0a6fe957db6790b2ed491e1729708469fe3a14be4ddf2d7efd1d1dd66a9b0814f55a35f504b28e97fc7b97f840202e036ee7927787a9bdfc9c6a8326cf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1379b14794c860268f2fbb5c9fdde8323d1178e92f4205ba06b30a4806c6b00e516052ffcb3d17e8ba2ad1601c0caeeea47490f380468bb6bec513700988915", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c4df9b4dd5f46d9f0e39b51b76ffcc8330ac623f77ba369bfcdb033d81a5cadcb24b7cbb2d4383d04d03e01900b5ee142b936163f9e88f6673f036f18eabcbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 17:16:22.891959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 17:16:22.892308) ========= 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=9f7544b6a75ada7b6b576032000001a7-1501197313.973849-499956074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 17:16:22.976955) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 17:16:22.979018) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 17:16:22.979360) ========= ========= Total master_lag: 0.24 =========