test-logtoprocess.t
73 lines
| 1.9 KiB
| text/troff
|
Tads3Lexer
/ tests / test-logtoprocess.t
|
r30991 | ATTENTION: logtoprocess runs commands asynchronously. Be sure to append "| cat" | ||
to hg commands, to wait for the output, if you want to test its output. | ||||
Otherwise the test will be flaky. | ||||
|
r28901 | Test if logtoprocess correctly captures command-related log calls. | ||
$ hg init | ||||
$ cat > $TESTTMP/foocommand.py << EOF | ||||
|
r32337 | > from mercurial import registrar | ||
|
r28901 | > from time import sleep | ||
> cmdtable = {} | ||||
|
r32337 | > command = registrar.command(cmdtable) | ||
|
r28901 | > @command('foo', []) | ||
> def foo(ui, repo): | ||||
> ui.log('foo', 'a message: %(bar)s\n', bar='spam') | ||||
> EOF | ||||
|
r30976 | $ cp $HGRCPATH $HGRCPATH.bak | ||
|
r28901 | $ cat >> $HGRCPATH << EOF | ||
> [extensions] | ||||
> logtoprocess= | ||||
> foocommand=$TESTTMP/foocommand.py | ||||
> [logtoprocess] | ||||
> command=echo 'logtoprocess command output:'; | ||||
> echo "\$EVENT"; | ||||
> echo "\$MSG1"; | ||||
> echo "\$MSG2" | ||||
> commandfinish=echo 'logtoprocess commandfinish output:'; | ||||
> echo "\$EVENT"; | ||||
> echo "\$MSG1"; | ||||
> echo "\$MSG2"; | ||||
> echo "\$MSG3" | ||||
> foo=echo 'logtoprocess foo output:'; | ||||
> echo "\$EVENT"; | ||||
> echo "\$MSG1"; | ||||
> echo "\$OPT_BAR" | ||||
> EOF | ||||
Running a command triggers both a ui.log('command') and a | ||||
ui.log('commandfinish') call. The foo command also uses ui.log. | ||||
|
r30991 | Use sort to avoid ordering issues between the various processes we spawn: | ||
$ hg foo | cat | sort | ||||
|
r28901 | |||
0 | ||||
a message: spam | ||||
command | ||||
commandfinish | ||||
foo | ||||
foo | ||||
foo | ||||
foo | ||||
foo exited 0 after * seconds (glob) | ||||
logtoprocess command output: | ||||
logtoprocess commandfinish output: | ||||
logtoprocess foo output: | ||||
spam | ||||
|
r30976 | |||
Confirm that logging blocked time catches stdio properly: | ||||
$ cp $HGRCPATH.bak $HGRCPATH | ||||
$ cat >> $HGRCPATH << EOF | ||||
> [extensions] | ||||
> logtoprocess= | ||||
> pager= | ||||
> [logtoprocess] | ||||
|
r30978 | > uiblocked=echo "\$EVENT stdio \$OPT_STDIO_BLOCKED ms command \$OPT_COMMAND_DURATION ms" | ||
|
r30976 | > [ui] | ||
> logblockedtimes=True | ||||
> EOF | ||||
|
r30991 | $ hg log | cat | ||
|
r30978 | uiblocked stdio [0-9]+.[0-9]* ms command [0-9]+.[0-9]* ms (re) | ||