Bug#913984: FTBFS: test-suite failure on armel: daqueue-dirty-shutdown

2018-11-18 Thread Michael Biebl
On Sun, 18 Nov 2018 01:23:10 +0100 Michael Biebl  wrote:
> Source: rsyslog
> Version: 8.39.0-1
> Severity: serious
> Forwarded: https://github.com/rsyslog/rsyslog/issues/2122
> 
> The test-suite fails on armel for the daqueue-dirty-shutdown test
> https://buildd.debian.org/status/fetch.php?pkg=rsyslog=armel=8.39.0-1=1540991734=0
> 

Another recent example is
https://tests.reproducible-builds.org/debian/logs/unstable/amd64/rsyslog_8.39.0-1.build2.log.gz
on amd64

-- 
Why is it that all of the instruments seeking intelligent life in the
universe are pointed away from Earth?



signature.asc
Description: OpenPGP digital signature


Bug#913984: FTBFS: test-suite failure on armel: daqueue-dirty-shutdown

2018-11-17 Thread Michael Biebl
Source: rsyslog
Version: 8.39.0-1
Severity: serious
Forwarded: https://github.com/rsyslog/rsyslog/issues/2122

The test-suite fails on armel for the daqueue-dirty-shutdown test
https://buildd.debian.org/status/fetch.php?pkg=rsyslog=armel=8.39.0-1=1540991734=0

FAIL: daqueue-dirty-shutdown



Test: ./daqueue-dirty-shutdown.sh

testbench: TZ env var not set, setting it to UTC
config rstb_821467_8113cd96_.conf is:
 1  module(load="../plugins/imdiag/.libs/imdiag")
 2  global(inputs.timeout.shutdown="6")
 3  $IMDiagListenPortFileName rstb_821467_8113cd96.imdiag.port
 4  $IMDiagServerRun 0
 5
 6  :syslogtag, contains, "rsyslogd"  ./rstb_821467_8113cd96.started
 7  ## end of testbench instrumentation part, test conf follows:
 8
 9  module(load="../plugins/omtesting/.libs/omtesting")
10
11  # set spool locations and switch queue to disk-only mode
12  $WorkDirectory rstb_821467_8113cd96.spool
13  main_queue(queue.filename="mainq" queue.saveonshutdown="on"
14 queue.timeoutshutdown="1" queue.maxfilesize="1m"
15 queue.timeoutworkerthreadshutdown="500" queue.size="20"
16 )
17
18  $template outfmt,"%msg:F,58:2%\n"
19  template(name="dynfile" type="string" 
string="rstb_821467_8113cd96.out.log")
20  #:msg, contains, "msgnum:" ?dynfile;outfmt
21  :msg, contains, "msgnum:" :omtesting:sleep 10 0
rsyslogd: NOTE: RSYSLOG_DEBUG_TIMEOUTS_TO_STDERR activated
rstb_821467_8113cd96:.pid1 found, pid 24631
rsyslogd startup msg seen, pid  24631
imdiag port: 39057
injecting 21 messages
imdiag[39057]: 21 messages injected
spool files immediately before shutdown:
mainq.0001
mainq.0002
mainq.0003
mainq.0004
mainq.0005
mainq.0006
mainq.0007
mainq.0008
mainq.0009
mainq.0010
mainq.0011
mainq.0012
mainq.0013
mainq.0014
mainq.0015
mainq.0016
mainq.0017
mainq.0018
mainq.qi
rsyslogd debug: info: trying to cooperatively stop input 
../plugins/imdiag/.libs/imdiag, timeout 6 ms
rsyslogd debug: main Q:DAwpool: worker start requested during shutdown - ignored
rsyslog internal message (6,-2041): main Q: regular queue shutdown timed out on 
primary queue (this is OK, timeout was 1) [v8.39.0 try 
http://www.rsyslog.com/e/2041 ]
rsyslog internal message (6,-2041): main Q: regular queue shutdown timed out on 
DA queue (this is OK, timeout was 1) [v8.39.0 try http://www.rsyslog.com/e/2041 
]
spool files immediately after shutdown (but before kill):
mainq.0001
mainq.0002
mainq.0003
mainq.0004
mainq.0005
mainq.0006
mainq.0007
mainq.0008
mainq.0009
mainq.0010
mainq.0011
mainq.0012
mainq.0013
mainq.0014
mainq.0015
mainq.0016
mainq.0017
mainq.0018
mainq.0019
mainq.0020
mainq.0021
mainq.0022
mainq.0023
mainq.0024
mainq.0025
mainq.0026
mainq.0027
mainq.qi
wait on shutdown of 24631
./diag.sh: line 407: 24631 Killed  LD_PRELOAD= 
../tools/rsyslogd -C -n -irstb_821467_8113cd96:.pid -M../runtime/.libs:../.libs 
-frstb_821467_8113cd96_.conf
spool files after kill:
mainq.0001
mainq.0002
mainq.0003
mainq.0004
mainq.0005
mainq.0006
mainq.0007
mainq.0008
mainq.0009
mainq.0010
mainq.0011
mainq.0012
mainq.0013
mainq.0014
mainq.0015
mainq.0016
mainq.0017
mainq.0018
mainq.0019
mainq.0020
mainq.0021
mainq.0022
mainq.0023
mainq.0024
mainq.0025
mainq.0026
mainq.0027
mainq.qi
.qi file contents:
End
.
End
.
End
.
RSYSLOG RESTART
mkdir: cannot create directory 'rstb_821467_8113cd96.spool': File exists
config rstb_821467_8113cd96_.conf is:
 1  module(load="../plugins/imdiag/.libs/imdiag")
 2  global(inputs.timeout.shutdown="6")
 3  $IMDiagListenPortFileName rstb_821467_8113cd96.imdiag.port
 4  $IMDiagServerRun 0
 5
 6  :syslogtag, contains, "rsyslogd"  ./rstb_821467_8113cd96.started
 7  ## end of testbench instrumentation part, test conf follows:
 8
 9  module(load="../plugins/omtesting/.libs/omtesting")
10
11  # set spool locations and switch queue to disk-only mode
12  $WorkDirectory rstb_821467_8113cd96.spool
13  main_queue(queue.filename="mainq" queue.saveonshutdown="on"
14 queue.timeoutshutdown="1" queue.maxfilesize="1m"
15 queue.timeoutworkerthreadshutdown="500" queue.size="20"
16 )
17
18  $template outfmt,"%msg:F,58:2%\n"
19  template(name="dynfile" type="string" 
string="rstb_821467_8113cd96.out.log")
20  :msg, contains, "msgnum:" ?dynfile;outfmt
rsyslogd: NOTE: RSYSLOG_DEBUG_TIMEOUTS_TO_STDERR activated
rstb_821467_8113cd96:.pid1 found, pid 24684
rsyslogd startup