32-bit named sometimes fails to start in doth test
Job #2440515 failed for cab15392:
S:doth:2022-04-11T08:39:50+0000
T:doth:1:A
A:doth:System test doth
I:doth:PORTS:30179,30180,30181,30182,30183,30184,30185,30186,30187,30188,30189,30190,30191
I:doth:starting servers
I:doth:Couldn't start server /builds/isc-private/bind9/bin/named/named -D doth-ns1 -X named.lock -m record -c named.conf -d 99 -g -U 4 -T maxcachesize=2097152 >named.run 2>&1 & echo $! (pid=1600)
I:doth:failed
I:doth:ns1 didn't die when sent a SIGTERM
I:doth:starting servers failed
I:doth:No tests were found and run
I:doth:Core dump(s) found: doth/ns1/core.1600
D:doth:backtrace from doth/ns1/core.1600:
D:doth:--------------------------------------------------------------------------------
D:doth:Core was generated by `/builds/isc-private/bind9/bin/named/.libs/named -D doth-ns1 -X named.lock -m re'.
D:doth:Program terminated with signal SIGABRT, Aborted.
D:doth:#0 0xf7f98069 in __kernel_vsyscall ()
D:doth:[Current thread is 1 (Thread 0xf4f384c0 (LWP 1600))]
D:doth:#0 0xf7f98069 in __kernel_vsyscall ()
D:doth:#1 0xf72b4cd2 in sigtimedwait () from /lib/i386-linux-gnu/libc.so.6
D:doth:#2 0xf747c13d in sigwait () from /lib/i386-linux-gnu/libpthread.so.0
D:doth:#3 0xf7cba3e4 in isc_app_ctxrun (ctx=<optimized out>) at app.c:236
D:doth:#4 0xf7cba57b in isc_app_run () at app.c:288
D:doth:#5 0x5663b81a in main (argc=16, argv=0xff99aa34) at main.c:1459
D:doth:--------------------------------------------------------------------------------
D:doth:full backtrace from doth/ns1/core.1600 saved in doth/ns1/core.1600-backtrace.txt
D:doth:core dump doth/ns1/core.1600 archived as doth/ns1/core.1600.gz
R:doth:FAIL
E:doth:2022-04-11T08:41:53+0000
FAIL doth (exit status: 1)
Lines about named
listening on interfaces is missing (ns1 named.run
):
11-Apr-2022 08:39:50.952 starting BIND 9.19.0 (Development Release) <id:cab1539>
11-Apr-2022 08:39:50.952 running on Linux x86_64 4.19.0-9-amd64 #1 SMP Debian 4.19.118-2+deb10u1 (2020-06-07)
11-Apr-2022 08:39:50.952 built with '--disable-maintainer-mode' '--enable-developer' '--enable-option-checking=fatal' '--enable-dnstap' '--with-cmocka' '--with-libxml2' '--with-json-c' '--build=x86_64-linux-gnu' '--host=i686-linux-gnu' '--with-libidn2' '--with-readline=libedit' 'build_alias=x86_64-linux-gnu' 'host_alias=i686-linux-gnu' 'CFLAGS=-fno-omit-frame-pointer -fno-optimize-sibling-calls -O1 -g -Wall -Wextra'
11-Apr-2022 08:39:50.952 running as: named -D doth-ns1 -X named.lock -m record -c named.conf -d 99 -g -U 4 -T maxcachesize\=2097152
11-Apr-2022 08:39:50.952 compiled by GCC 10.2.1 20210110
11-Apr-2022 08:39:50.952 compiled with OpenSSL version: OpenSSL 1.1.1k 25 Mar 2021
11-Apr-2022 08:39:50.952 linked to OpenSSL version: OpenSSL 1.1.1k 25 Mar 2021
11-Apr-2022 08:39:50.952 compiled with libxml2 version: 2.9.10
11-Apr-2022 08:39:50.952 linked to libxml2 version: 20910
11-Apr-2022 08:39:50.952 compiled with json-c version: 0.15
11-Apr-2022 08:39:50.952 linked to json-c version: 0.15
11-Apr-2022 08:39:50.952 compiled with zlib version: 1.2.11
11-Apr-2022 08:39:50.952 linked to zlib version: 1.2.11
11-Apr-2022 08:39:50.952 ----------------------------------------------------
11-Apr-2022 08:39:50.952 BIND 9 is maintained by Internet Systems Consortium,
11-Apr-2022 08:39:50.952 Inc. (ISC), a non-profit 501(c)(3) public-benefit
11-Apr-2022 08:39:50.952 corporation. Support and training for BIND 9 are
11-Apr-2022 08:39:50.952 available at https://www.isc.org/support
11-Apr-2022 08:39:50.952 ----------------------------------------------------
11-Apr-2022 08:39:50.952 found 12 CPUs, using 12 worker threads
11-Apr-2022 08:39:50.952 using 4 UDP listeners per interface
11-Apr-2022 08:39:50.960 Registering DLZ_dlopen driver
11-Apr-2022 08:39:50.960 Registering SDLZ driver 'dlopen'
11-Apr-2022 08:39:50.960 Registering DLZ driver 'dlopen'
11-Apr-2022 08:39:50.980 config.c: option 'trust-anchor-telemetry' is experimental and subject to change in the future
11-Apr-2022 08:39:50.980 loading configuration from '/builds/isc-private/bind9/bin/tests/system/doth/ns1/named.conf'
11-Apr-2022 08:39:50.980 unable to open '/usr/local/etc/bind.keys'; using built-in keys instead
11-Apr-2022 08:39:50.980 exclusive task mode: starting
11-Apr-2022 08:39:51.004 exclusive task mode: started
11-Apr-2022 08:39:51.004 set maximum stack size to 18446744073709551615: success
11-Apr-2022 08:39:51.004 set maximum data size to 18446744073709551615: success
11-Apr-2022 08:39:51.004 set maximum core size to 18446744073709551615: success
11-Apr-2022 08:39:51.004 set maximum open files to 18446744073709551615: success
11-Apr-2022 08:39:51.004 looking for GeoIP2 databases in '/usr/share/GeoIP'
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoIP2-Country.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoLite2-Country.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoIP2-City.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoLite2-City.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoIP2-ASN.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoLite2-ASN.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoIP2-ISP.mmdb' (status 1)
11-Apr-2022 08:39:51.004 unable to open GeoIP2 database '/usr/share/GeoIP/GeoIP2-Domain.mmdb' (status 1)
11-Apr-2022 08:39:51.004 using default UDP/IPv4 port range: [32768, 60999]
11-Apr-2022 08:39:51.004 using default UDP/IPv6 port range: [32768, 60999]
Happened a day before in the 2439503 job, again doth
system test.
Note that this job employs 32-bit BIND with 32-bit dependencies on otherwise 64-bit system.