Package: emacs;
Reported by: Stefan Kangas <stefankangas <at> gmail.com>
Date: Tue, 29 Aug 2023 06:46:02 UTC
Severity: normal
Found in versions 29.0.50, 30.0.50
To reply to this bug, email your comments to 65590 AT debbugs.gnu.org.
Toggle the display of automated, internal messages from the tracker.
View this report as an mbox folder, status mbox, maintainer mbox
jporterbugs <at> gmail.com, bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Tue, 29 Aug 2023 06:46:02 GMT) Full text and rfc822 format available.Stefan Kangas <stefankangas <at> gmail.com>:jporterbugs <at> gmail.com, bug-gnu-emacs <at> gnu.org.
(Tue, 29 Aug 2023 06:46:02 GMT) Full text and rfc822 format available.Message #5 received at submit <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: bug-gnu-emacs <bug-gnu-emacs <at> gnu.org> Subject: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 29 Aug 2023 08:44:22 +0200
X-Debbugs-CC: jporterbugs <at> gmail.com
I see the below test failure on macOS:
Test esh-var-test/interp-concat-cmd backtrace:
signal(error ("echo: unrecognized option -b"))
error("%s: unrecognized option -%c" "echo" 98)
eshell--process-option("echo" "baz" 0 0 ((110 nil (nil) output-newli
eshell--process-args("echo" ("-baz") ((110 nil (nil) output-newline
eshell--do-opts("echo" ((110 nil (nil) output-newline "do not output
eshell/echo("-baz")
apply(eshell/echo "-baz")
eshell-exec-lisp(eshell-print eshell-error eshell/echo ("-baz") nil)
eshell-lisp-command(eshell/echo ("-baz"))
eshell-plain-command("echo" ("-baz"))
eshell-named-command("echo" ("-baz"))
eval((eshell-named-command '"echo" '("-baz")))
eshell-do-eval((eshell-named-command '"echo" '("-baz")) t)
eshell-do-eval((prog1 (eshell-named-command '"echo" '("-baz")) (mapc
(condition-case err (eshell-do-eval '(prog1 (eshell-named-command '"
eval((condition-case err (eshell-do-eval '(prog1 (eshell-named-comma
eshell-do-eval((condition-case err (eshell-do-eval '(prog1 (eshell-n
#f(compiled-function () #<bytecode -0x107543402033a9af>)()
funcall(#f(compiled-function () #<bytecode -0x107543402033a9af>))
(let ((eshell-this-command-hook '(ignore))) (funcall '#f(compiled-fu
eval((let ((eshell-this-command-hook '(ignore))) (funcall '#f(compil
eshell-do-eval((let ((eshell-this-command-hook '(ignore))) (conditio
#f(compiled-function () #<bytecode -0x107543402033a9af>)()
funcall(#f(compiled-function () #<bytecode -0x107543402033a9af>))
(let ((eshell-current-handles '[nil (((eshell-temp) . 2) t) (((eshel
eval((let ((eshell-current-handles '[nil ((... . 2) t) ((... . 2) t)
eshell-do-eval((let ((eshell-current-handles '[nil ((... . 2) t) ((.
eshell-do-eval((progn (let ((eshell-current-handles '[nil (... t) (.
#f(compiled-function () #<bytecode -0x107543402033a9af>)()
funcall(#f(compiled-function () #<bytecode -0x107543402033a9af>))
(let ((eshell-in-pipeline-p 'nil) (eshell-current-handles '[nil (((e
eval((let ((eshell-in-pipeline-p 'nil) (eshell-current-handles '[nil
eshell-do-eval((let ((eshell-in-pipeline-p 'nil) (eshell-current-han
#f(compiled-function () #<bytecode -0x107543402033a9af>)()
funcall(#f(compiled-function () #<bytecode -0x107543402033a9af>))
(let ((eshell-current-handles '[nil (((t) . 2) t) (((t) . 2) t)]) (e
eval((let ((eshell-current-handles '[nil ((... . 2) t) ((... . 2) t)
eshell-do-eval((let ((eshell-current-handles '[nil ((... . 2) t) ((.
eshell-command-result("echo ${*echo \"foo\nbar\"}-baz")
eshell-test-command-result("echo ${*echo \"foo\nbar\"}-baz")
eshell-command-result-equal("echo ${*echo \"foo\nbar\"}-baz" ("foo"
#f(compiled-function () #<bytecode -0x1e41ac0e460bffe0>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-var-test/interp-concat-cmd :docum
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-var-tests
command-line()
normal-top-level()
Test esh-var-test/interp-concat-cmd condition:
(error "echo: unrecognized option -b")
FAILED 20/110 esh-var-test/interp-concat-cmd (0.616546 sec) at
lisp/eshell/esh-var-tests.el:275
In GNU Emacs 30.0.50 (build 2, x86_64-apple-darwin21.6.0, NS
appkit-2113.60 Version 12.6.8 (Build 21G725)) of 2023-08-28 built on
MY-MacBook-Pro.local
Repository revision: 7a55d7e8684c02551feb17168047c9192478e5a0
Repository branch: master
Windowing system distributor 'Apple', version 10.3.2113
System Description: macOS 12.6.8
Configured features:
ACL GIF GMP GNUTLS JPEG JSON LCMS2 LIBXML2 MODULES NOTIFY KQUEUE NS
PDUMPER PNG SQLITE3 THREADS TIFF TOOLKIT_SCROLL_BARS TREE_SITTER WEBP
XIM ZLIB
Important settings:
value of $LC_COLLATE: C
value of $LC_CTYPE: sv_SE.UTF-8
locale-coding-system: utf-8-unix
Major mode: Lisp Interaction
Minor modes in effect:
tooltip-mode: t
global-eldoc-mode: t
eldoc-mode: t
show-paren-mode: t
electric-indent-mode: t
mouse-wheel-mode: t
tool-bar-mode: t
menu-bar-mode: t
file-name-shadow-mode: t
global-font-lock-mode: t
font-lock-mode: t
blink-cursor-mode: t
line-number-mode: t
indent-tabs-mode: t
transient-mark-mode: t
auto-composition-mode: t
auto-encryption-mode: t
auto-compression-mode: t
Load-path shadows:
None found.
Features:
(shadow sort mail-extr emacsbug message mailcap yank-media puny dired
dired-loaddefs rfc822 mml mml-sec password-cache epa derived epg rfc6068
epg-config gnus-util text-property-search time-date subr-x mm-decode
mm-bodies mm-encode mail-parse rfc2231 mailabbrev gmm-utils mailheader
cl-loaddefs cl-lib sendmail rfc2047 rfc2045 ietf-drums mm-util
mail-prsvr mail-utils rmc iso-transl tooltip cconv eldoc paren electric
uniquify ediff-hook vc-hooks lisp-float-type elisp-mode mwheel
term/ns-win ns-win ucs-normalize mule-util term/common-win touch-screen
tool-bar dnd fontset image regexp-opt fringe tabulated-list replace
newcomment text-mode lisp-mode prog-mode register page tab-bar menu-bar
rfn-eshadow isearch easymenu timer select scroll-bar mouse jit-lock
font-lock syntax font-core term/tty-colors frame minibuffer nadvice seq
simple cl-generic indonesian philippine cham georgian utf-8-lang
misc-lang vietnamese tibetan thai tai-viet lao korean japanese eucjp-ms
cp51932 hebrew greek romanian slovak czech european ethiopic indian
cyrillic chinese composite emoji-zwj charscript charprop case-table
epa-hook jka-cmpr-hook help abbrev obarray oclosure cl-preloaded button
loaddefs theme-loaddefs faces cus-face macroexp files window
text-properties overlay sha1 md5 base64 format env code-pages mule
custom widget keymap hashtable-print-readable backquote threads kqueue
cocoa ns lcms2 multi-tty make-network-process emacs)
Memory information:
((conses 16 36151 9219) (symbols 48 5093 0) (strings 32 12636 1004)
(string-bytes 1 352850) (vectors 16 9370)
(vector-slots 8 147689 12388) (floats 8 21 23) (intervals 56 202 0)
(buffers 992 10))
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Tue, 29 Aug 2023 17:11:01 GMT) Full text and rfc822 format available.Message #8 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com>, 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 29 Aug 2023 10:10:12 -0700
On 8/28/2023 11:44 PM, Stefan Kangas wrote:
> X-Debbugs-CC: jporterbugs <at> gmail.com
>
> I see the below test failure on macOS:
>
> Test esh-var-test/interp-concat-cmd backtrace:
> signal(error ("echo: unrecognized option -b"))
> error("%s: unrecognized option -%c" "echo" 98)
> eshell--process-option("echo" "baz" 0 0 ((110 nil (nil) output-newli
> eshell--process-args("echo" ("-baz") ((110 nil (nil) output-newline
> eshell--do-opts("echo" ((110 nil (nil) output-newline "do not output
> eshell/echo("-baz")
> apply(eshell/echo "-baz")
[snip]
> eshell-command-result("echo ${*echo \"foo\nbar\"}-baz")
> eshell-test-command-result("echo ${*echo \"foo\nbar\"}-baz")
> eshell-command-result-equal("echo ${*echo \"foo\nbar\"}-baz" ("foo"
> #f(compiled-function () #<bytecode -0x1e41ac0e460bffe0>)()
> ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
> ert-run-test(#s(ert-test :name esh-var-test/interp-concat-cmd :docum
> ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
> ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
> ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
> ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
> eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
> command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-var-tests
> command-line()
> normal-top-level()
> Test esh-var-test/interp-concat-cmd condition:
> (error "echo: unrecognized option -b")
> FAILED 20/110 esh-var-test/interp-concat-cmd (0.616546 sec) at
> lisp/eshell/esh-var-tests.el:275
This looks like a race condition when executing this command:
echo ${*echo "foo\nbar"}-baz
That *should* print "foo\nbar-baz", but it tries to print "-baz" (and
fails). That appears to be because the subcommand (*echo "foo\nbar")
produces no output.
I'll inspect the code here more to see if there are any obvious places
that we're not waiting long enough for the output. However, I've never
been able to reproduce this locally, so it might be time to add more
debug instrumentation to Eshell...
(Michael Albinus - CCed - has also seen similar sorts of issues on EMBA.
They're usually different tests that fail, but they all look like
similar issues where we get no output from a subcommand.)
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Tue, 29 Aug 2023 19:01:01 GMT) Full text and rfc822 format available.Message #11 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 29 Aug 2023 20:59:48 +0200
Jim Porter <jporterbugs <at> gmail.com> writes:
> This looks like a race condition when executing this command:
>
> echo ${*echo "foo\nbar"}-baz
>
> That *should* print "foo\nbar-baz", but it tries to print "-baz" (and
> fails). That appears to be because the subcommand (*echo "foo\nbar")
> produces no output.
I can confirm that the error is intermittent, as I'm not seeing it on a re-run.
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Tue, 29 Aug 2023 19:16:02 GMT) Full text and rfc822 format available.Message #14 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 29 Aug 2023 21:15:11 +0200
Den tis 29 aug. 2023 kl 20:59 skrev Stefan Kangas <stefankangas <at> gmail.com>:
>
> Jim Porter <jporterbugs <at> gmail.com> writes:
>
> > This looks like a race condition when executing this command:
> >
> > echo ${*echo "foo\nbar"}-baz
> >
> > That *should* print "foo\nbar-baz", but it tries to print "-baz" (and
> > fails). That appears to be because the subcommand (*echo "foo\nbar")
> > produces no output.
>
> I can confirm that the error is intermittent, as I'm not seeing it on a re-run.
(I put "29.0.50" in the subject, but that should be "30.0.50". Sorry
about the typo.)
And on yet another re-run, this one cropped up in the same file:
Test esh-var-test/quote-interp-var-indices-subcommand backtrace:
signal(ert-test-failed (((should (eshell-command-result--equal comma
ert-fail(((should (eshell-command-result--equal command (eshell-test
eshell-command-result-equal("echo \"$eshell-test-value[${*echo 0}]\"
#f(compiled-function () #<bytecode -0x3e28235b46afdbe>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-var-test/quote-interp-var-indices
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-var-tests
command-line()
normal-top-level()
Test esh-var-test/quote-interp-var-indices-subcommand condition:
(ert-test-failed
((should
(eshell-command-result--equal command
(eshell-test-command-result command)
result))
:form
(eshell-command-result--equal
"echo \"$eshell-test-value[${*echo 0}]\"" #("nil" 0 3 (escaped t))
"zero")
:value nil :explanation
(nonequal-result (command "echo \"$eshell-test-value[${*echo 0}]\"")
(result #("nil" 0 3 ...)) (expected "zero"))))
FAILED 76/110 esh-var-test/quote-interp-var-indices-subcommand
(0.625851 sec) at lisp/eshell/esh-var-tests.el:341
[...]
Ran 110 tests, 108 results as expected, 2 unexpected (2023-08-29
21:10:03+0200, 10.074424 sec)
2 unexpected results:
FAILED esh-var-test/interp-cmd-external
FAILED esh-var-test/quote-interp-var-indices-subcommand
make[3]: *** [lisp/eshell/esh-var-tests.log] Error 1
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 30 Aug 2023 00:45:02 GMT) Full text and rfc822 format available.Message #17 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 29 Aug 2023 17:44:28 -0700
[Message part 1 (text/plain, inline)]
On 8/29/2023 11:59 AM, Stefan Kangas wrote:
> Jim Porter <jporterbugs <at> gmail.com> writes:
>
>> This looks like a race condition when executing this command:
>>
>> echo ${*echo "foo\nbar"}-baz
>>
>> That *should* print "foo\nbar-baz", but it tries to print "-baz" (and
>> fails). That appears to be because the subcommand (*echo "foo\nbar")
>> produces no output.
>
> I can confirm that the error is intermittent, as I'm not seeing it on a re-run.
Can you try the following patches? They shouldn't change the behavior,
but they do add some extra debugging information to failed tests.
If you can get this to occur when using Eshell interactively, you can
also enable this output by calling "eshell-debug process" at an Eshell
prompt before running the offending command.
[0001-Fix-handling-of-Eshell-debug-modes.patch (text/plain, attachment)]
[0002-Add-debug-instrumentation-for-Eshell-process-managem.patch (text/plain, attachment)]
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Fri, 01 Sep 2023 01:55:01 GMT) Full text and rfc822 format available.Message #20 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Thu, 31 Aug 2023 18:54:24 -0700
On 8/29/2023 5:44 PM, Jim Porter wrote: > Can you try the following patches? They shouldn't change the behavior, > but they do add some extra debugging information to failed tests. To help diagnose some similar EMBA failures, I've pushed these patches to master. Hopefully, we'll get some useful debug info.
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Fri, 01 Sep 2023 16:04:01 GMT) Full text and rfc822 format available.Message #23 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Fri, 1 Sep 2023 18:03:20 +0200
[Message part 1 (text/plain, inline)]
Jim Porter <jporterbugs <at> gmail.com> writes: > > On 8/29/2023 5:44 PM, Jim Porter wrote: > > Can you try the following patches? They shouldn't change the behavior, > > but they do add some extra debugging information to failed tests. > > To help diagnose some similar EMBA failures, I've pushed these patches > to master. Hopefully, we'll get some useful debug info. Thanks. Please see the attached files, with debug logs from these test failures: SUMMARY OF TEST RESULTS ----------------------- Files examined: 492 Ran 7306 tests, 6974 results as expected, 5 unexpected, 233 skipped 4 files did not finish: lisp/eshell/eshell-tests.log lisp/eshell/esh-var-tests.log lisp/eshell/esh-io-tests.log lisp/eshell/esh-cmd-tests.log 5 files contained unexpected results: lisp/progmodes/etags-tests.log lisp/eshell/eshell-tests.log lisp/eshell/esh-var-tests.log lisp/eshell/esh-io-tests.log lisp/eshell/esh-cmd-tests.log make[2]: *** [check-doit] Error 2 make[1]: *** [check] Error 2 make: *** [check] Error 2 Compilation exited abnormally with code 2 at Fri Sep 1 17:51:35, duration 0:08:10
[esh-io-tests.log.gz (application/x-gzip, attachment)]
[esh-cmd-tests.log.gz (application/x-gzip, attachment)]
[eshell-tests.log.gz (application/x-gzip, attachment)]
[esh-var-tests.log.gz (application/x-gzip, attachment)]
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Fri, 01 Sep 2023 16:31:02 GMT) Full text and rfc822 format available.Message #26 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Fri, 1 Sep 2023 09:30:21 -0700
On 9/1/2023 9:03 AM, Stefan Kangas wrote:
> Jim Porter <jporterbugs <at> gmail.com> writes:
>>
>> On 8/29/2023 5:44 PM, Jim Porter wrote:
>>> Can you try the following patches? They shouldn't change the behavior,
>>> but they do add some extra debugging information to failed tests.
>>
>> To help diagnose some similar EMBA failures, I've pushed these patches
>> to master. Hopefully, we'll get some useful debug info.
>
> Thanks. Please see the attached files, with debug logs from these
> test failures:
Hmm, that's not right. Did you do a full recompile of all the Eshell
code/tests? The errors should look something like this (just an example
from me forcing a test to fail):
------------------------------------------------------------
Test esh-proc-test/output/to-screen condition:
Command logs: command: "sh -c 'echo stdout; echo stderr >&2'"
----------------------------------------
[process] started external process `sh'
----------------------------------------
[process] received output from process `sh'
stdout
stderr
----------------------------------------
[process] sentinel for external process `sh': "finished
"
----------------------------------------
[process] finished external process `sh'
(ert-test-failed
((should (eshell-match-output regexp)) :form
(eshell-match-output "[TEST]stdout\nstderr\n") :value nil
:explanation
(mismatched-output
(command "sh -c 'echo stdout; echo stderr >&2'\n")
(output "stdout\nstderr\n") (regexp "[TEST]stdout\nstderr\n"))))
FAILED 11/21 esh-proc-test/output/to-screen (0.105507 sec) at
../../test/lisp/eshell/esh-proc-tests.el:52
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Fri, 01 Sep 2023 17:01:02 GMT) Full text and rfc822 format available.Message #29 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Fri, 1 Sep 2023 10:00:33 -0700
On 9/1/2023 9:30 AM, Jim Porter wrote: > On 9/1/2023 9:03 AM, Stefan Kangas wrote: >> Thanks. Please see the attached files, with debug logs from these >> test failures: > > Hmm, that's not right. Did you do a full recompile of all the Eshell > code/tests? I also pushed a small fix to the debugging code to master as da8b323f82417697f9b772689810099f426fe616, but that shouldn't affect this case (much).
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Tue, 12 Sep 2023 18:54:02 GMT) Full text and rfc822 format available.Message #32 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Tue, 12 Sep 2023 11:53:17 -0700
On 9/1/2023 10:00 AM, Jim Porter wrote: > I also pushed a small fix to the debugging code to master as > da8b323f82417697f9b772689810099f426fe616, but that shouldn't affect this > case (much). I pushed a couple more correctness fixes for Eshell's process management to master as fad91b56d13. Hopefully these will help matters (but to be fair, I'm a little skeptical that the bug I fixed is the same as this bug...)
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 16:12:03 GMT) Full text and rfc822 format available.Message #35 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Wed, 13 Sep 2023 09:10:52 -0700
Jim Porter <jporterbugs <at> gmail.com> writes:
> On 9/1/2023 10:00 AM, Jim Porter wrote:
>> I also pushed a small fix to the debugging code to master as
>> da8b323f82417697f9b772689810099f426fe616, but that shouldn't affect this
>> case (much).
>
> I pushed a couple more correctness fixes for Eshell's process management
> to master as fad91b56d13. Hopefully these will help matters (but to be
> fair, I'm a little skeptical that the bug I fixed is the same as this
> bug...)
Sorry for the slow turnaround time.
I'm currently seeing these test failures on master:
Running 46 tests (2023-09-13 16:46:00+0200, selector ‘(not (or (tag
:expensive-test) (tag :unstable) (tag :nativecomp)))’)
Loading em-alias...
Loading em-banner...
Loading em-basic...
Loading em-cmpl...
Loading em-extpipe...
Loading em-glob...
Loading em-hist...
Loading em-ls...
Loading em-pred...
Loading em-prompt...
Loading em-script...
Loading em-term...
Loading em-unix...
passed 1/46 esh-cmd-test/and-operator (0.259946 sec)
passed 2/46 esh-cmd-test/backquoted-lisp-form (0.001679 sec)
passed 3/46 esh-cmd-test/backquoted-lisp-form/splice (0.001686 sec)
passed 4/46 esh-cmd-test/for-loop (0.006714 sec)
passed 5/46 esh-cmd-test/for-loop-for-items-shadow (0.004334 sec)
passed 6/46 esh-cmd-test/for-loop-list (0.003476 sec)
passed 7/46 esh-cmd-test/for-loop-multiple-args (0.006086 sec)
passed 8/46 esh-cmd-test/for-loop-name (0.002023 sec)
passed 9/46 esh-cmd-test/for-loop-name-shadow (0.003343 sec)
passed 10/46 esh-cmd-test/for-loop-pipe (0.112573 sec)
passed 11/46 esh-cmd-test/if-else-statement (0.031268 sec)
passed 12/46 esh-cmd-test/if-else-statement-ext-cmd (0.126054 sec)
passed 13/46 esh-cmd-test/if-else-statement-lisp-form (0.005082 sec)
passed 14/46 esh-cmd-test/if-else-statement-lisp-form-2 (0.004613 sec)
passed 15/46 esh-cmd-test/if-else-statement-pipe (0.239692 sec)
passed 16/46 esh-cmd-test/if-statement (0.003869 sec)
passed 17/46 esh-cmd-test/if-statement-pipe (0.226295 sec)
passed 18/46 esh-cmd-test/let-rebinds-after-defer (0.113418 sec)
passed 19/46 esh-cmd-test/lisp-command (0.002054 sec)
passed 20/46 esh-cmd-test/lisp-command-args (0.002587 sec)
passed 21/46 esh-cmd-test/lisp-command-with-quote (0.001719 sec)
passed 22/46 esh-cmd-test/or-operator (0.233849 sec)
passed 23/46 esh-cmd-test/pipeline-wait/head-proc (0.113463 sec)
passed 24/46 esh-cmd-test/pipeline-wait/multi-proc (1.045003 sec)
passed 25/46 esh-cmd-test/pipeline-wait/subcommand (0.119225 sec)
passed 26/46 esh-cmd-test/pipeline-wait/subcommand-with-pipe (0.137609 sec)
passed 27/46 esh-cmd-test/pipeline-wait/tail-proc (0.124454 sec)
passed 28/46 esh-cmd-test/quoted-lisp-form (0.002298 sec)
Test esh-cmd-test/reset-in-pipeline/lisp backtrace:
signal(ert-test-failed (((should (eshell-command-result--equal comma
ert-fail(((should (eshell-command-result--equal command (eshell-test
eshell-command-result-equal("echo $(format \"%s\" eshell-in-pipeline
#f(compiled-function () #<bytecode 0xaa47d7f4bc36b29>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-cmd-test/reset-in-pipeline/lisp :
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-cmd-tests
command-line()
normal-top-level()
Test esh-cmd-test/reset-in-pipeline/lisp condition:
Command logs: command: "echo $(format "%s" eshell-in-pipeline-p) | *cat"
----------------------------------------
[process] started external process ‘cat’
(ert-test-failed
((should
(eshell-command-result--equal command
(eshell-test-command-result command)
result))
:form
(eshell-command-result--equal
"echo $(format \"%s\" eshell-in-pipeline-p) | *cat" nil "nil")
:value nil :explanation
(nonequal-result
(command "echo $(format \"%s\" eshell-in-pipeline-p) | *cat")
(result nil) (expected "nil"))))
FAILED 29/46 esh-cmd-test/reset-in-pipeline/lisp (0.087616 sec)
at lisp/eshell/esh-cmd-tests.el:203
Test esh-cmd-test/reset-in-pipeline/subcommand backtrace:
signal(ert-test-failed (((should (eshell-command-result--equal comma
ert-fail(((should (eshell-command-result--equal command (eshell-test
eshell-command-result-equal("echo {echo | echo $eshell-in-pipeline-p
#f(compiled-function () #<bytecode 0x1a4482f59c3edde8>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-cmd-test/reset-in-pipeline/subcom
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-cmd-tests
command-line()
normal-top-level()
Test esh-cmd-test/reset-in-pipeline/subcommand condition:
Command logs: command: "echo {echo | echo $eshell-in-pipeline-p} | *cat"
----------------------------------------
[process] started external process ‘cat’
(ert-test-failed
((should
(eshell-command-result--equal command
(eshell-test-command-result command)
result))
:form
(eshell-command-result--equal
"echo {echo | echo $eshell-in-pipeline-p} | *cat" nil "last")
:value nil :explanation
(nonequal-result
(command "echo {echo | echo $eshell-in-pipeline-p} | *cat")
(result nil) (expected "last"))))
FAILED 30/46 esh-cmd-test/reset-in-pipeline/subcommand (0.078130
sec) at lisp/eshell/esh-cmd-tests.el:184
passed 31/46 esh-cmd-test/simple-command-result (0.003985 sec)
passed 32/46 esh-cmd-test/subcommand (0.005324 sec)
passed 33/46 esh-cmd-test/subcommand-args (0.002383 sec)
passed 34/46 esh-cmd-test/subcommand-lisp (0.001339 sec)
passed 35/46 esh-cmd-test/subcommand-shadow-value (0.002534 sec)
passed 36/46 esh-cmd-test/unless-else-statement (0.017221 sec)
Test esh-cmd-test/unless-else-statement-ext-cmd backtrace:
signal(ert-test-failed (((should (eshell-command-result--equal comma
ert-fail(((should (eshell-command-result--equal command (eshell-test
eshell-command-result-equal("unless {[ foo = bar ]} {echo no} {echo
#f(compiled-function () #<bytecode -0x9ffeea180f72755>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-cmd-test/unless-else-statement-ex
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-cmd-tests
command-line()
normal-top-level()
Test esh-cmd-test/unless-else-statement-ext-cmd condition:
Command logs: command: "unless {[ foo = bar ]} {echo no} {echo yes}"
----------------------------------------
[process] started external process ‘[<1>’
(ert-test-failed
((should
(eshell-command-result--equal command
(eshell-test-command-result command)
result))
:form
(eshell-command-result--equal
"unless {[ foo = bar ]} {echo no} {echo yes}" "yes" "no")
:value nil :explanation
(nonequal-result
(command "unless {[ foo = bar ]} {echo no} {echo yes}")
(result "yes") (expected "no"))))
FAILED 37/46 esh-cmd-test/unless-else-statement-ext-cmd (0.031509
sec) at lisp/eshell/esh-cmd-tests.el:431
passed 38/46 esh-cmd-test/unless-else-statement-lisp-form (0.007760 sec)
passed 39/46 esh-cmd-test/unless-statement (0.003845 sec)
passed 40/46 esh-cmd-test/until-loop (0.010837 sec)
passed 41/46 esh-cmd-test/until-loop-ext-cmd (0.125156 sec)
passed 42/46 esh-cmd-test/until-loop-lisp-form (0.009843 sec)
passed 43/46 esh-cmd-test/while-loop (0.012687 sec)
passed 44/46 esh-cmd-test/while-loop-ext-cmd (0.155605 sec)
passed 45/46 esh-cmd-test/while-loop-lisp-form (0.004418 sec)
passed 46/46 esh-cmd-test/while-loop-pipe (0.120805 sec)
Ran 46 tests, 43 results as expected, 3 unexpected (2023-09-13
16:46:05+0200, 4.562085 sec)
3 unexpected results:
FAILED esh-cmd-test/reset-in-pipeline/lisp
FAILED esh-cmd-test/reset-in-pipeline/subcommand
FAILED esh-cmd-test/unless-else-statement-ext-cmd
Stefan Kangas <stefankangas <at> gmail.com>
to control <at> debbugs.gnu.org.
(Wed, 13 Sep 2023 17:31:01 GMT) Full text and rfc822 format available.bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 18:55:02 GMT) Full text and rfc822 format available.Message #40 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Wed, 13 Sep 2023 11:54:00 -0700
[Message part 1 (text/plain, inline)]
On 9/13/2023 9:10 AM, Stefan Kangas wrote: > Sorry for the slow turnaround time. > > I'm currently seeing these test failures on master: [snip] Thanks for the logs. Could you try the attached patch to see if it improves things?
[0001-When-waiting-for-processes-in-Eshell-wait-until-all-.patch (text/plain, attachment)]
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 20:35:02 GMT) Full text and rfc822 format available.Message #43 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Wed, 13 Sep 2023 13:34:07 -0700
Jim Porter <jporterbugs <at> gmail.com> writes: > Thanks for the logs. Could you try the attached patch to see if it > improves things? Thanks. The tests do not seem to fail with that patch: GEN lisp/eshell/esh-cmd-tests.log I was seeing some intermittent deadlocks in esh-cmd-tests.el at first, but not yet after I rebased your patch on top of the fixes you just pushed to master. So for now, your patch seems to improve things. I'll report back if I see the deadlocks again.
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 20:42:01 GMT) Full text and rfc822 format available.Message #46 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Jim Porter <jporterbugs <at> gmail.com> To: Stefan Kangas <stefankangas <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Wed, 13 Sep 2023 13:41:03 -0700
On 9/13/2023 1:34 PM, Stefan Kangas wrote: > Jim Porter <jporterbugs <at> gmail.com> writes: > >> Thanks for the logs. Could you try the attached patch to see if it >> improves things? > > Thanks. The tests do not seem to fail with that patch: > > GEN lisp/eshell/esh-cmd-tests.log > > I was seeing some intermittent deadlocks in esh-cmd-tests.el at first, > but not yet after I rebased your patch on top of the fixes you just > pushed to master. > > So for now, your patch seems to improve things. I'll report back if I > see the deadlocks again. Thanks. Pushed to master as 9838f786ded. This hopefully resolves this bug, along with bug#59103 and bug#65601.
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 20:49:02 GMT) Full text and rfc822 format available.Message #49 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com> To: Jim Porter <jporterbugs <at> gmail.com> Cc: 65590 <at> debbugs.gnu.org, michael.albinus <at> gmx.de Subject: Re: bug#65590: 29.0.50; esh-var-test/interp-concat-cmd fails on macOS Date: Wed, 13 Sep 2023 13:48:05 -0700
Jim Porter <jporterbugs <at> gmail.com> writes: > Thanks. Pushed to master as 9838f786ded. This hopefully resolves this > bug, along with bug#59103 and bug#65601. Thanks for the fix, and feel free to close this bug and the others (note that I merged some of them). We can always reopen this if these issues resurface.
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 21:12:02 GMT) Full text and rfc822 format available.Message #52 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com>
To: Jim Porter <jporterbugs <at> gmail.com>
Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org, 65602 <at> debbugs.gnu.org
Subject: Re: bug#65602: 30.0.50;
eshell-test/{elisp,subcommand}-reset-in-pipeline
fails intermittently on macOS
Date: Wed, 13 Sep 2023 14:10:55 -0700
Stefan Kangas <stefankangas <at> gmail.com> writes:
> Jim Porter <jporterbugs <at> gmail.com> writes:
>
>> Thanks. Pushed to master as 9838f786ded. This hopefully resolves this
>> bug, along with bug#59103 and bug#65601.
>
> Thanks for the fix, and feel free to close this bug and the others (note
> that I merged some of them).
>
> We can always reopen this if these issues resurface.
I spoke too soon, as I'm now seeing the below two failures.
FAILED 42/110 esh-var-test/interp-var-indices-subcommand
(0.787189 sec) at lisp/eshell/esh-var-tests.el:184
FAILED 5/11 eshell-test/eshell-command/simple (0.670351 sec) at
lisp/eshell/eshell-tests.el:41
I'm trying to reproduce it a second time, but they don't always show up.
Meanwhile, here is the complete log:
Running 110 tests (2023-09-13 22:35:13+0200, selector ‘(not (or (tag
:expensive-test) (tag :unstable) (tag :nativecomp)))’)
Loading em-alias...
Loading em-banner...
Loading em-basic...
Loading em-cmpl...
Loading em-extpipe...
Loading em-glob...
Loading em-hist...
Loading em-ls...
Loading em-pred...
Loading em-prompt...
Loading em-script...
Loading em-term...
Loading em-unix...
passed 1/110 esh-var-test/alias/export (0.088465 sec)
passed 2/110 esh-var-test/alias/function (0.002535 sec)
passed 3/110 esh-var-test/alias/function-pair (0.001671 sec)
passed 4/110 esh-var-test/alias/local-variables (0.005713 sec)
passed 5/110 esh-var-test/alias/string (0.003960 sec)
passed 6/110 esh-var-test/alias/string/prefer-lisp (0.002671 sec)
passed 7/110 esh-var-test/alias/symbol (0.003753 sec)
passed 8/110 esh-var-test/alias/symbol-pair (0.002834 sec)
passed 9/110 esh-var-test/columns-var (0.002136 sec)
passed 10/110 esh-var-test/command-interp (0.001959 sec)
passed 11/110 esh-var-test/command-interp-splice (0.002680 sec)
passed 12/110 esh-var-test/export (0.002692 sec)
passed 13/110 esh-var-test/gid-var (0.001037 sec)
passed 14/110 esh-var-test/inside-emacs-var (0.003868 sec)
passed 15/110 esh-var-test/inside-emacs-var-split-indices (0.002742 sec)
passed 16/110 esh-var-test/interp-cmd (0.010029 sec)
passed 17/110 esh-var-test/interp-cmd-external (0.109887 sec)
passed 18/110 esh-var-test/interp-cmd-external-indices (0.119196 sec)
passed 19/110 esh-var-test/interp-cmd-indices (0.017139 sec)
passed 20/110 esh-var-test/interp-concat-cmd (0.230823 sec)
passed 21/110 esh-var-test/interp-concat-cmd-external (0.113160 sec)
passed 22/110 esh-var-test/interp-concat-cmd2 (0.006122 sec)
passed 23/110 esh-var-test/interp-concat-lisp (0.002987 sec)
passed 24/110 esh-var-test/interp-concat-lisp2 (0.002998 sec)
passed 25/110 esh-var-test/interp-convert-cmd-multiline (0.006679 sec)
passed 26/110 esh-var-test/interp-convert-cmd-number (0.001994 sec)
passed 27/110 esh-var-test/interp-convert-cmd-split-indices (0.003176 sec)
passed 28/110 esh-var-test/interp-convert-cmd-string-newline
(0.001614 sec)
passed 29/110 esh-var-test/interp-convert-quoted-var-number (0.004028 sec)
passed 30/110
esh-var-test/interp-convert-quoted-var-split-indices (0.002890 sec)
passed 31/110 esh-var-test/interp-convert-var-number (0.002947 sec)
passed 32/110 esh-var-test/interp-convert-var-split-indices (0.007150 sec)
passed 33/110 esh-var-test/interp-lisp (0.001717 sec)
passed 34/110 esh-var-test/interp-lisp-indices (0.001671 sec)
passed 35/110 esh-var-test/interp-list-var (0.001838 sec)
passed 36/110 esh-var-test/interp-list-var-concat (0.001501 sec)
passed 37/110 esh-var-test/interp-quoted-var (0.003192 sec)
passed 38/110 esh-var-test/interp-quoted-var-concat (0.003008 sec)
passed 39/110 esh-var-test/interp-temp-cmd (0.015746 sec)
passed 40/110 esh-var-test/interp-var (0.001530 sec)
passed 41/110 esh-var-test/interp-var-assoc (0.004526 sec)
Test esh-var-test/interp-var-indices-subcommand backtrace:
signal(ert-test-failed (((should (eshell-command-result--equal comma
ert-fail(((should (eshell-command-result--equal command (eshell-test
eshell-command-result-equal("echo $eshell-test-value[${*echo 0} ${*e
#f(compiled-function () #<bytecode 0xa6a8df2b60ef482>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-var-test/interp-var-indices-subco
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-var-tests
command-line()
normal-top-level()
Test esh-var-test/interp-var-indices-subcommand condition:
Command logs: command: "echo $eshell-test-value[${*echo 0} ${*echo 2}]"
----------------------------------------
[process] started external process ‘echo’
----------------------------------------
[process] sentinel for external process ‘echo’: "finished
"
----------------------------------------
[process] finished external process ‘echo’
----------------------------------------
[process] started external process ‘echo’
----------------------------------------
[process] received output from process ‘echo’
2
----------------------------------------
[process] sentinel for external process ‘echo’: "finished
"
----------------------------------------
[process] finished external process ‘echo’
(ert-test-failed
((should
(eshell-command-result--equal command
(eshell-test-command-result command)
result))
:form
(eshell-command-result--equal
"echo $eshell-test-value[${*echo 0} ${*echo 2}]" (nil "two")
("zero" "two"))
:value nil :explanation
(nonequal-result
(command "echo $eshell-test-value[${*echo 0} ${*echo 2}]")
(result (nil "two")) (expected ("zero" "two")))))
FAILED 42/110 esh-var-test/interp-var-indices-subcommand
(0.787189 sec) at lisp/eshell/esh-var-tests.el:184
passed 43/110 esh-var-test/interp-var-indices/list (0.019358 sec)
passed 44/110 esh-var-test/interp-var-indices/ring (0.020269 sec)
passed 45/110 esh-var-test/interp-var-indices/split (0.037000 sec)
passed 46/110 esh-var-test/interp-var-indices/vector (0.026923 sec)
passed 47/110 esh-var-test/interp-var-length-alist (0.010415 sec)
passed 48/110 esh-var-test/interp-var-length-list (0.006603 sec)
passed 49/110 esh-var-test/interp-var-length-string (0.002292 sec)
passed 50/110 esh-var-test/interp-var-regexp-split-indices (0.242747 sec)
passed 51/110 esh-var-test/interp-var-splice (0.002365 sec)
passed 52/110 esh-var-test/interp-var-splice-concat (0.004213 sec)
passed 53/110 esh-var-test/interp-var-string-split-indices (0.016318 sec)
passed 54/110 esh-var-test/last-arg-var (0.009780 sec)
passed 55/110 esh-var-test/last-arg-var-indices (0.039239 sec)
passed 56/110 esh-var-test/last-arg-var-split-indices (0.028203 sec)
passed 57/110 esh-var-test/last-result-var (0.006147 sec)
passed 58/110 esh-var-test/last-result-var-ext-cmd (0.266221 sec)
passed 59/110 esh-var-test/last-result-var-split-indices (0.010959 sec)
passed 60/110 esh-var-test/last-result-var-twice (0.006037 sec)
passed 61/110 esh-var-test/last-status-var-ext-cmd (0.231988 sec)
passed 62/110 esh-var-test/last-status-var-lisp-command (0.009926 sec)
passed 63/110 esh-var-test/last-status-var-lisp-form (0.006611 sec)
passed 64/110 esh-var-test/last-status-var-lisp-form-2 (0.005176 sec)
passed 65/110 esh-var-test/lines-var (0.002246 sec)
passed 66/110 esh-var-test/local-variables (0.006088 sec)
passed 67/110 esh-var-test/pager-var/default (0.003803 sec)
passed 68/110 esh-var-test/pager-var/set (0.005817 sec)
passed 69/110 esh-var-test/pager-var/set-locally (0.012370 sec)
passed 70/110 esh-var-test/pager-var/unset (0.005745 sec)
passed 71/110 esh-var-test/path-var/local-directory (0.002657 sec)
Tramp: Sending command ‘exec sh -i’
Tramp: Found remote shell prompt on ‘SK-MacBook-Pro’
passed 72/110 esh-var-test/path-var/preserve-across-hosts (0.633738 sec)
passed 73/110 esh-var-test/path-var/remote-directory (0.008255 sec)
passed 74/110 esh-var-test/path-var/set (0.002298 sec)
passed 75/110 esh-var-test/path-var/set-locally (0.006185 sec)
passed 76/110 esh-var-test/quote-interp-var-indices-subcommand
(0.200504 sec)
passed 77/110 esh-var-test/quoted-interp-cmd (0.003089 sec)
passed 78/110 esh-var-test/quoted-interp-cmd-indices (0.003972 sec)
passed 79/110 esh-var-test/quoted-interp-concat-cmd (0.002686 sec)
passed 80/110 esh-var-test/quoted-interp-convert-cmd-multiline
(0.002652 sec)
passed 81/110 esh-var-test/quoted-interp-convert-cmd-number (0.002783 sec)
passed 82/110
esh-var-test/quoted-interp-convert-cmd-split-indices (0.003088 sec)
passed 83/110
esh-var-test/quoted-interp-convert-cmd-string-newline (0.004199 sec)
passed 84/110
esh-var-test/quoted-interp-convert-quoted-var-number (0.006084 sec)
passed 85/110
esh-var-test/quoted-interp-convert-quoted-var-split-indices (0.004098
sec)
passed 86/110 esh-var-test/quoted-interp-convert-var-number (0.002988 sec)
passed 87/110
esh-var-test/quoted-interp-convert-var-split-indices (0.004272 sec)
passed 88/110 esh-var-test/quoted-interp-lisp (0.001916 sec)
passed 89/110 esh-var-test/quoted-interp-lisp-indices (0.003084 sec)
passed 90/110 esh-var-test/quoted-interp-list-var (0.001994 sec)
passed 91/110 esh-var-test/quoted-interp-list-var-concat (0.001896 sec)
passed 92/110 esh-var-test/quoted-interp-quoted-var (0.002696 sec)
passed 93/110 esh-var-test/quoted-interp-temp-cmd (0.014113 sec)
passed 94/110 esh-var-test/quoted-interp-var (0.001652 sec)
passed 95/110 esh-var-test/quoted-interp-var-assoc (0.003079 sec)
passed 96/110 esh-var-test/quoted-interp-var-indices (0.006305 sec)
passed 97/110 esh-var-test/quoted-interp-var-length-alist (0.004078 sec)
passed 98/110 esh-var-test/quoted-interp-var-length-list (0.005522 sec)
passed 99/110 esh-var-test/quoted-interp-var-length-string (0.001733 sec)
passed 100/110
esh-var-test/quoted-interp-var-regexp-split-indices (0.006641 sec)
passed 101/110 esh-var-test/quoted-interp-var-splice (0.001625 sec)
passed 102/110 esh-var-test/quoted-interp-var-splice-concat (0.001853 sec)
passed 103/110 esh-var-test/quoted-interp-var-split-indices (0.004032 sec)
passed 104/110
esh-var-test/quoted-interp-var-string-split-indices (0.011405 sec)
passed 105/110 esh-var-test/set/env-var (0.002622 sec)
passed 106/110 esh-var-test/set/symbol (0.001815 sec)
passed 107/110 esh-var-test/setq (0.001772 sec)
passed 108/110 esh-var-test/uid-var (0.001575 sec)
passed 109/110 esh-var-test/unset/env-var (0.002218 sec)
passed 110/110 esh-var-test/unset/symbol (0.001740 sec)
Ran 110 tests, 109 results as expected, 1 unexpected (2023-09-13
22:35:17+0200, 3.917546 sec)
1 unexpected results:
FAILED esh-var-test/interp-var-indices-subcommand
Running 11 tests (2023-09-13 22:35:15+0200, selector ‘(not (or (tag
:expensive-test) (tag :unstable) (tag :nativecomp)))’)
Loading em-alias...
Loading em-banner...
Loading em-basic...
Loading em-cmpl...
Loading em-extpipe...
Loading em-glob...
Loading em-hist...
Loading em-ls...
Loading em-pred...
Loading em-prompt...
Loading em-script...
Loading em-term...
Loading em-unix...
passed 1/11 eshell-test/command-running-p (0.091010 sec)
[echo]+ Done (/bin/echo hi)
passed 2/11 eshell-test/eshell-command/background (0.127438 sec)
[echo]+ Done (/bin/echo hi)
[cat]+ Done (/bin/cat)
passed 3/11 eshell-test/eshell-command/background-pipeline (0.128145 sec)
passed 4/11 eshell-test/eshell-command/pipeline (0.082343 sec)
Test eshell-test/eshell-command/simple backtrace:
signal(ert-test-failed (((should (equal (buffer-string) "hi\n")) :fo
ert-fail(((should (equal (buffer-string) "hi\n")) :form (equal "" "h
#f(compiled-function () #<bytecode -0x15f19fdff774913f>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name eshell-test/eshell-command/simple :do
ert-run-or-rerun-test(#s(ert--stats :selector (not (or ... ... ...))
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/eshell-tests"
command-line()
normal-top-level()
Test eshell-test/eshell-command/simple condition:
(ert-test-failed
((should (equal (buffer-string) "hi\n")) :form (equal "" "hi\n")
:value nil :explanation
(arrays-of-different-length 0 3 "" "hi\n" first-mismatch-at 0)))
FAILED 5/11 eshell-test/eshell-command/simple (0.670351 sec) at
lisp/eshell/eshell-tests.el:41
passed 6/11 eshell-test/flush-output (0.006822 sec)
passed 7/11 eshell-test/forward-arg (0.004067 sec)
passed 8/11 eshell-test/get-old-input (0.001915 sec)
passed 9/11 eshell-test/get-old-input/rerun-command (0.007355 sec)
passed 10/11 eshell-test/get-old-input/run-output (0.002997 sec)
passed 11/11 eshell-test/queue-input (1.041617 sec)
Ran 11 tests, 10 results as expected, 1 unexpected (2023-09-13
22:35:17+0200, 2.483635 sec)
1 unexpected results:
FAILED eshell-test/eshell-command/simple
GEN lisp/format-spec-tests.log
make[3]: *** [lisp/eshell/eshell-tests.log] Error 1
make[3]: *** [lisp/eshell/esh-var-tests.log] Error 1
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 21:14:01 GMT) Full text and rfc822 format available.Message #55 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com>
To: Jim Porter <jporterbugs <at> gmail.com>
Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org, 65602 <at> debbugs.gnu.org
Subject: Re: bug#65602: 30.0.50;
eshell-test/{elisp,subcommand}-reset-in-pipeline
fails intermittently on macOS
Date: Wed, 13 Sep 2023 14:13:00 -0700
Jim Porter <jporterbugs <at> gmail.com> writes:
> Thanks. Pushed to master as 9838f786ded. This hopefully resolves this
> bug, along with bug#59103 and bug#65601.
On a subsequent re-run, I'm now seeing this failure in em-unix-tests.el
too:
Running 4 tests (2023-09-13 23:09:59+0200, selector ‘(not (or (tag
:expensive-test) (tag :unstable) (tag :nativecomp)))’)
Loading em-alias...
Loading em-banner...
Loading em-basic...
Loading em-cmpl...
Loading em-extpipe...
Loading em-glob...
Loading em-hist...
Loading em-ls...
Loading em-pred...
Loading em-prompt...
Loading em-script...
Loading em-term...
passed 1/4 em-unix-test/compile/interactive (0.126190 sec)
Compilation finished
passed 2/4 em-unix-test/compile/noninteractive (0.065006 sec)
passed 3/4 em-unix-test/compile/pipeline (0.148928 sec)
Test em-unix-test/compile/subcommand backtrace:
signal(ert-test-failed (((should (eshell-match-output regexp)) :form
ert-fail(((should (eshell-match-output regexp)) :form (eshell-match-
eshell-match-command-output("echo ${compile echo hello}" "\\`hello\n
#f(compiled-function () #<bytecode 0x407c24691ea495>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name em-unix-test/compile/subcommand :docu
ert-run-or-rerun-test(#s(ert--stats :selector (not (or ... ... ...))
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/em-unix-tests
command-line()
normal-top-level()
Test em-unix-test/compile/subcommand condition:
Command logs: command: "echo ${compile echo hello}"
----------------------------------------
[process] started external process ‘echo’
----------------------------------------
[process] sentinel for external process ‘echo’: "finished
"
----------------------------------------
[process] finished external process ‘echo’
(ert-test-failed
((should (eshell-match-output regexp)) :form
(eshell-match-output "\\`hello\n") :value nil :explanation
(mismatched-output (command "echo ${compile echo hello}\n")
(output "") (regexp "\\`hello\n"))))
FAILED 4/4 em-unix-test/compile/subcommand (0.727038 sec) at
lisp/eshell/em-unix-tests.el:60
Ran 4 tests, 3 results as expected, 1 unexpected (2023-09-13
23:10:00+0200, 1.300818 sec)
1 unexpected results:
FAILED em-unix-test/compile/subcommand
make[3]: *** [lisp/eshell/em-unix-tests.log] Error 1
bug-gnu-emacs <at> gnu.org:bug#65590; Package emacs.
(Wed, 13 Sep 2023 21:34:02 GMT) Full text and rfc822 format available.Message #58 received at 65590 <at> debbugs.gnu.org (full text, mbox):
From: Stefan Kangas <stefankangas <at> gmail.com>
To: Jim Porter <jporterbugs <at> gmail.com>
Cc: michael.albinus <at> gmx.de, 65590 <at> debbugs.gnu.org, 65602 <at> debbugs.gnu.org
Subject: Re: bug#65602: 30.0.50;
eshell-test/{elisp,subcommand}-reset-in-pipeline
fails intermittently on macOS
Date: Wed, 13 Sep 2023 14:33:25 -0700
Stefan Kangas <stefankangas <at> gmail.com> writes:
> I spoke too soon, as I'm now seeing the below two failures.
>
> FAILED 42/110 esh-var-test/interp-var-indices-subcommand (0.787189 sec) at lisp/eshell/esh-var-tests.el:184
>
> FAILED 5/11 eshell-test/eshell-command/simple (0.670351 sec) at lisp/eshell/eshell-tests.el:41
Here's another one I saw in another rerun:
FAILED esh-var-test/interp-concat-cmd-external
Running 110 tests (2023-09-13 23:19:42+0200, selector ‘(not (or (tag
:expensive-test) (tag :unstable) (tag :nativecomp)))’)
Loading em-alias...
Loading em-banner...
Loading em-basic...
Loading em-cmpl...
Loading em-extpipe...
Loading em-glob...
Loading em-hist...
Loading em-ls...
Loading em-pred...
Loading em-prompt...
Loading em-script...
Loading em-term...
Loading em-unix...
passed 1/110 esh-var-test/alias/export (0.178462 sec)
passed 2/110 esh-var-test/alias/function (0.003780 sec)
passed 3/110 esh-var-test/alias/function-pair (0.004611 sec)
passed 4/110 esh-var-test/alias/local-variables (0.006019 sec)
passed 5/110 esh-var-test/alias/string (0.004543 sec)
passed 6/110 esh-var-test/alias/string/prefer-lisp (0.002898 sec)
passed 7/110 esh-var-test/alias/symbol (0.003406 sec)
passed 8/110 esh-var-test/alias/symbol-pair (0.007461 sec)
passed 9/110 esh-var-test/columns-var (0.012501 sec)
passed 10/110 esh-var-test/command-interp (0.007292 sec)
passed 11/110 esh-var-test/command-interp-splice (0.004153 sec)
passed 12/110 esh-var-test/export (0.006411 sec)
passed 13/110 esh-var-test/gid-var (0.002620 sec)
passed 14/110 esh-var-test/inside-emacs-var (0.004839 sec)
passed 15/110 esh-var-test/inside-emacs-var-split-indices (0.002154 sec)
passed 16/110 esh-var-test/interp-cmd (0.004522 sec)
passed 17/110 esh-var-test/interp-cmd-external (0.112656 sec)
passed 18/110 esh-var-test/interp-cmd-external-indices (0.113898 sec)
passed 19/110 esh-var-test/interp-cmd-indices (0.003645 sec)
passed 20/110 esh-var-test/interp-concat-cmd (0.205057 sec)
Test esh-var-test/interp-concat-cmd-external backtrace:
signal(ert-test-failed (((should (eshell-match-output regexp)) :form
ert-fail(((should (eshell-match-output regexp)) :form (eshell-match-
eshell-match-command-output("echo ${echo hi}-${*echo there}" "hi-the
#f(compiled-function () #<bytecode 0x498530d8d28fcbf>)()
ert--run-test-internal(#s(ert--test-execution-info :test #s(ert-test
ert-run-test(#s(ert-test :name esh-var-test/interp-concat-cmd-extern
ert-run-or-rerun-test(#s(ert--stats :selector ... :tests ... :test-m
ert-run-tests((not (or (tag :expensive-test) (tag :unstable) (tag :n
ert-run-tests-batch((not (or (tag :expensive-test) (tag :unstable) (
ert-run-tests-batch-and-exit((not (or (tag :expensive-test) (tag :un
eval((ert-run-tests-batch-and-exit '(not (or (tag :expensive-test) (
command-line-1(("-L" ":." "-l" "ert" "-l" "lisp/eshell/esh-var-tests
command-line()
normal-top-level()
Test esh-var-test/interp-concat-cmd-external condition:
Command logs: command: "echo ${echo hi}-${*echo there}"
----------------------------------------
[process] started external process ‘echo’
----------------------------------------
[process] sentinel for external process ‘echo’: "finished
"
----------------------------------------
[process] finished external process ‘echo’
(ert-test-failed
((should (eshell-match-output regexp)) :form
(eshell-match-output "hi-there\n") :value nil :explanation
(mismatched-output (command "echo ${echo hi}-${*echo there}\n")
(output "hi-\n") (regexp "hi-there\n"))))
FAILED 21/110 esh-var-test/interp-concat-cmd-external (0.728591
sec) at lisp/eshell/esh-var-tests.el:292
passed 22/110 esh-var-test/interp-concat-cmd2 (0.004187 sec)
passed 23/110 esh-var-test/interp-concat-lisp (0.002859 sec)
passed 24/110 esh-var-test/interp-concat-lisp2 (0.004121 sec)
passed 25/110 esh-var-test/interp-convert-cmd-multiline (0.004131 sec)
passed 26/110 esh-var-test/interp-convert-cmd-number (0.001232 sec)
passed 27/110 esh-var-test/interp-convert-cmd-split-indices (0.005519 sec)
passed 28/110 esh-var-test/interp-convert-cmd-string-newline
(0.001249 sec)
passed 29/110 esh-var-test/interp-convert-quoted-var-number (0.003763 sec)
passed 30/110
esh-var-test/interp-convert-quoted-var-split-indices (0.002441 sec)
passed 31/110 esh-var-test/interp-convert-var-number (0.004204 sec)
passed 32/110 esh-var-test/interp-convert-var-split-indices (0.007541 sec)
passed 33/110 esh-var-test/interp-lisp (0.003046 sec)
passed 34/110 esh-var-test/interp-lisp-indices (0.003134 sec)
passed 35/110 esh-var-test/interp-list-var (0.002291 sec)
passed 36/110 esh-var-test/interp-list-var-concat (0.001819 sec)
passed 37/110 esh-var-test/interp-quoted-var (0.003009 sec)
passed 38/110 esh-var-test/interp-quoted-var-concat (0.003025 sec)
passed 39/110 esh-var-test/interp-temp-cmd (0.013814 sec)
passed 40/110 esh-var-test/interp-var (0.001271 sec)
passed 41/110 esh-var-test/interp-var-assoc (0.004091 sec)
passed 42/110 esh-var-test/interp-var-indices-subcommand (0.176522 sec)
passed 43/110 esh-var-test/interp-var-indices/list (0.013073 sec)
passed 44/110 esh-var-test/interp-var-indices/ring (0.011317 sec)
passed 45/110 esh-var-test/interp-var-indices/split (0.011973 sec)
passed 46/110 esh-var-test/interp-var-indices/vector (0.012646 sec)
passed 47/110 esh-var-test/interp-var-length-alist (0.002014 sec)
passed 48/110 esh-var-test/interp-var-length-list (0.005285 sec)
passed 49/110 esh-var-test/interp-var-length-string (0.001555 sec)
passed 50/110 esh-var-test/interp-var-regexp-split-indices (0.010098 sec)
passed 51/110 esh-var-test/interp-var-splice (0.001259 sec)
passed 52/110 esh-var-test/interp-var-splice-concat (0.002406 sec)
passed 53/110 esh-var-test/interp-var-string-split-indices (0.009873 sec)
passed 54/110 esh-var-test/last-arg-var (0.005632 sec)
passed 55/110 esh-var-test/last-arg-var-indices (0.021506 sec)
passed 56/110 esh-var-test/last-arg-var-split-indices (0.011228 sec)
passed 57/110 esh-var-test/last-result-var (0.005804 sec)
passed 58/110 esh-var-test/last-result-var-ext-cmd (0.226047 sec)
passed 59/110 esh-var-test/last-result-var-split-indices (0.031719 sec)
passed 60/110 esh-var-test/last-result-var-twice (0.004827 sec)
passed 61/110 esh-var-test/last-status-var-ext-cmd (0.242608 sec)
passed 62/110 esh-var-test/last-status-var-lisp-command (0.010839 sec)
passed 63/110 esh-var-test/last-status-var-lisp-form (0.005407 sec)
passed 64/110 esh-var-test/last-status-var-lisp-form-2 (0.006529 sec)
passed 65/110 esh-var-test/lines-var (0.003589 sec)
passed 66/110 esh-var-test/local-variables (0.023687 sec)
passed 67/110 esh-var-test/pager-var/default (0.017587 sec)
passed 68/110 esh-var-test/pager-var/set (0.087502 sec)
passed 69/110 esh-var-test/pager-var/set-locally (0.012173 sec)
passed 70/110 esh-var-test/pager-var/unset (0.005189 sec)
passed 71/110 esh-var-test/path-var/local-directory (0.003602 sec)
Tramp: Sending command ‘exec sh -i’
Tramp: Found remote shell prompt on ‘SK-MacBook-Pro’
passed 72/110 esh-var-test/path-var/preserve-across-hosts (0.866043 sec)
passed 73/110 esh-var-test/path-var/remote-directory (0.083372 sec)
passed 74/110 esh-var-test/path-var/set (0.014802 sec)
passed 75/110 esh-var-test/path-var/set-locally (0.008608 sec)
passed 76/110 esh-var-test/quote-interp-var-indices-subcommand
(0.236072 sec)
passed 77/110 esh-var-test/quoted-interp-cmd (0.004823 sec)
passed 78/110 esh-var-test/quoted-interp-cmd-indices (0.047686 sec)
passed 79/110 esh-var-test/quoted-interp-concat-cmd (0.002995 sec)
passed 80/110 esh-var-test/quoted-interp-convert-cmd-multiline
(0.002892 sec)
passed 81/110 esh-var-test/quoted-interp-convert-cmd-number (0.002594 sec)
passed 82/110
esh-var-test/quoted-interp-convert-cmd-split-indices (0.002789 sec)
passed 83/110
esh-var-test/quoted-interp-convert-cmd-string-newline (0.005021 sec)
passed 84/110
esh-var-test/quoted-interp-convert-quoted-var-number (0.008607 sec)
passed 85/110
esh-var-test/quoted-interp-convert-quoted-var-split-indices (0.007789
sec)
passed 86/110 esh-var-test/quoted-interp-convert-var-number (0.002748 sec)
passed 87/110
esh-var-test/quoted-interp-convert-var-split-indices (0.007919 sec)
passed 88/110 esh-var-test/quoted-interp-lisp (0.001791 sec)
passed 89/110 esh-var-test/quoted-interp-lisp-indices (0.003300 sec)
passed 90/110 esh-var-test/quoted-interp-list-var (0.001912 sec)
passed 91/110 esh-var-test/quoted-interp-list-var-concat (0.002009 sec)
passed 92/110 esh-var-test/quoted-interp-quoted-var (0.003799 sec)
passed 93/110 esh-var-test/quoted-interp-temp-cmd (0.017058 sec)
passed 94/110 esh-var-test/quoted-interp-var (0.001892 sec)
passed 95/110 esh-var-test/quoted-interp-var-assoc (0.021957 sec)
passed 96/110 esh-var-test/quoted-interp-var-indices (0.017924 sec)
passed 97/110 esh-var-test/quoted-interp-var-length-alist (0.017236 sec)
passed 98/110 esh-var-test/quoted-interp-var-length-list (0.006038 sec)
passed 99/110 esh-var-test/quoted-interp-var-length-string (0.001831 sec)
passed 100/110
esh-var-test/quoted-interp-var-regexp-split-indices (0.017895 sec)
passed 101/110 esh-var-test/quoted-interp-var-splice (0.005310 sec)
passed 102/110 esh-var-test/quoted-interp-var-splice-concat (0.002805 sec)
passed 103/110 esh-var-test/quoted-interp-var-split-indices (0.005452 sec)
passed 104/110
esh-var-test/quoted-interp-var-string-split-indices (0.029075 sec)
passed 105/110 esh-var-test/set/env-var (0.002507 sec)
passed 106/110 esh-var-test/set/symbol (0.002819 sec)
passed 107/110 esh-var-test/setq (0.005122 sec)
passed 108/110 esh-var-test/uid-var (0.021527 sec)
passed 109/110 esh-var-test/unset/env-var (0.002078 sec)
passed 110/110 esh-var-test/unset/symbol (0.002711 sec)
Ran 110 tests, 109 results as expected, 1 unexpected (2023-09-13
23:19:46+0200, 4.193564 sec)
1 unexpected results:
FAILED esh-var-test/interp-concat-cmd-external
make[3]: *** [lisp/eshell/esh-var-tests.log] Error 1
GNU bug tracking system
Copyright (C) 1999 Darren O. Benham,
1997,2003 nCipher Corporation Ltd,
1994-97 Ian Jackson.