"dupsigs" system test intermittently causes named to hang
https://gitlab.isc.org/isc-private/bind9/-/jobs/2888774
It appears that named did not shut down upon receiving a SIGTERM
signal. Core dump was preserved.
Click to expand/collapse full test output
S:dupsigs:2022-11-07T23:09:10+0000
T:dupsigs:1:A
A:dupsigs:System test dupsigs
I:dupsigs:PORTRANGE:5300 - 5399
keys/signing.test/Ksigning.test.+008+01243.key
keys/signing.test/Ksigning.test.+008+01243.private
keys/signing.test/Ksigning.test.+008+18273.key
keys/signing.test/Ksigning.test.+008+18273.private
keys/signing.test/Ksigning.test.+008+31045.key
keys/signing.test/Ksigning.test.+008+31045.private
keys/signing.test/Ksigning.test.+008+34155.key
keys/signing.test/Ksigning.test.+008+34155.private
keys/signing.test/Ksigning.test.+008+39696.key
keys/signing.test/Ksigning.test.+008+39696.private
keys/signing.test/Ksigning.test.+008+48211.key
keys/signing.test/Ksigning.test.+008+48211.private
keys/signing.test/Ksigning.test.+008+49109.key
keys/signing.test/Ksigning.test.+008+49109.private
keys/signing.test/Ksigning.test.+008+50088.key
keys/signing.test/Ksigning.test.+008+50088.private
keys/signing.test/Ksigning.test.+008+52456.key
keys/signing.test/Ksigning.test.+008+52456.private
keys/signing.test/Ksigning.test.+008+54099.key
keys/signing.test/Ksigning.test.+008+54099.private
keys/signing.test/Ksigning.test.+008+57000.key
keys/signing.test/Ksigning.test.+008+57000.private
keys/signing.test/Ksigning.test.+008+49109.key
keys/signing.test/Ksigning.test.+008+49109.private
keys/signing.test/Ksigning.test.+008+01243.key
keys/signing.test/Ksigning.test.+008+01243.private
keys/signing.test/Ksigning.test.+008+01243.key
keys/signing.test/Ksigning.test.+008+01243.private
keys/signing.test/Ksigning.test.+008+18273.key
keys/signing.test/Ksigning.test.+008+18273.private
keys/signing.test/Ksigning.test.+008+01243.key
keys/signing.test/Ksigning.test.+008+01243.private
keys/signing.test/Ksigning.test.+008+18273.key
keys/signing.test/Ksigning.test.+008+18273.private
keys/signing.test/Ksigning.test.+008+54099.key
keys/signing.test/Ksigning.test.+008+54099.private
keys/signing.test/Ksigning.test.+008+18273.key
keys/signing.test/Ksigning.test.+008+18273.private
keys/signing.test/Ksigning.test.+008+54099.key
keys/signing.test/Ksigning.test.+008+54099.private
keys/signing.test/Ksigning.test.+008+57000.key
keys/signing.test/Ksigning.test.+008+57000.private
keys/signing.test/Ksigning.test.+008+50088.key
keys/signing.test/Ksigning.test.+008+50088.private
KSK=Ksigning.test.+008+49109
ZSK0=Ksigning.test.+008+01243
ZSK1=Ksigning.test.+008+18273
ZSK2=Ksigning.test.+008+54099
ZSK3=Ksigning.test.+008+57000
ZSK4=Ksigning.test.+008+50088
I:dupsigs:starting servers
=============== 0 ============
at serial 1996072701 key 1243 status added with flags (0,0)
at serial 1996072701 key 18273 status added with flags (0,0)
at serial 1996072701 key 49109 status added with flags (0,0)
at serial 1996072752 key 49109 status changed from (0,0) to (0,1)
=============== 35 ============
at serial 1996072701 key 1243 status added with flags (0,0)
at serial 1996072701 key 18273 status added with flags (0,0)
at serial 1996072701 key 49109 status added with flags (0,0)
at serial 1996072752 key 49109 status changed from (0,0) to (0,1)
I:dupsigs:failed
=============== 70 ============
at serial 1996072701 key 1243 status added with flags (0,0)
at serial 1996072701 key 18273 status added with flags (0,0)
at serial 1996072701 key 49109 status added with flags (0,0)
at serial 1996072752 key 49109 status changed from (0,0) to (0,1)
I:dupsigs:failed
=============== 105 ============
at serial 1996072701 key 1243 status added with flags (0,0)
at serial 1996072701 key 18273 status added with flags (0,0)
at serial 1996072701 key 49109 status added with flags (0,0)
at serial 1996072752 key 49109 status changed from (0,0) to (0,1)
I:dupsigs:failed
I:dupsigs:exit status: 3
I:dupsigs:stopping servers
I:dupsigs:ns1 didn't die when sent a SIGTERM
I:dupsigs:stopping servers failed
I:dupsigs:Core dump(s) found: dupsigs/ns1/core.6262
R:dupsigs:FAIL
D:dupsigs:backtrace from dupsigs/ns1/core.6262:
D:dupsigs:--------------------------------------------------------------------------------
D:dupsigs:Core was generated by `/builds/isc-private/bind9/bin/named/.libs/named -D dupsigs-ns1 -X named.lock -m'.
D:dupsigs:Program terminated with signal SIGABRT, Aborted.
D:dupsigs:#0 0x00007fc0aa3755c0 in __GI___nanosleep (requested_time=requested_time@entry=0x7ffcdf293790, remaining=remaining@entry=0x0) at ../sysdeps/unix/sysv/linux/nanosleep.c:28
D:dupsigs:[Current thread is 1 (Thread 0x7fc0a8091840 (LWP 6262))]
D:dupsigs:#0 0x00007fc0aa3755c0 in __GI___nanosleep (requested_time=requested_time@entry=0x7ffcdf293790, remaining=remaining@entry=0x0) at ../sysdeps/unix/sysv/linux/nanosleep.c:28
D:dupsigs:#1 0x00007fc0aa3a0414 in usleep (useconds=useconds@entry=10000) at ../sysdeps/posix/usleep.c:32
D:dupsigs:#2 0x00007fc0aaac7f03 in isc__taskmgr_destroy (managerp=managerp@entry=0x5567f5431d40 <named_g_taskmgr>) at task.c:1091
D:dupsigs:#3 0x00007fc0aaaa7ab2 in isc_managers_destroy (netmgrp=0x5567f5431d20 <named_g_nm>, taskmgrp=0x5567f5431d40 <named_g_taskmgr>) at managers.c:85
D:dupsigs:#4 0x00005567f53cdb1a in destroy_managers () at ./main.c:1742
D:dupsigs:#5 cleanup () at ./main.c:1478
D:dupsigs:#6 main (argc=<optimized out>, argv=<optimized out>) at ./main.c:1742
D:dupsigs:--------------------------------------------------------------------------------
D:dupsigs:full backtrace from dupsigs/ns1/core.6262 saved in dupsigs/ns1/core.6262-backtrace.txt
D:dupsigs:core dump dupsigs/ns1/core.6262 archived as dupsigs/ns1/core.6262.gz
E:dupsigs:2022-11-07T23:26:34+0000