dig +nssearch sometimes hangs in BIND v9.16, with an assertion failure after "ctrl+c"
This is a followup issue based on this and following comments by @leffeg in #3028 (closed) (which isn't related to the current issue).
Here are the dig -d
debug messages provided by @leffeg (and copy-pasted here) for a successful run and a failed run:
Succeeded
root@d01:~# gdb -batch -n -ex 'set pagination off' -ex run -ex bt -ex 'bt full' -ex 'thread apply all bt full' --args dig -d @ns.dnslab.se dnslab.se +nssearch
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
setup_libs()
[New Thread 0x7ffff4fce700 (LWP 42743)]
[New Thread 0x7ffff47cd700 (LWP 42744)]
[New Thread 0x7ffff3fa2700 (LWP 42745)]
setup_system()
create_search_list()
ndots is 1.
get_server_list()
make_server(::1)
dig_query_setup
parse_args()
making new lookup
make_empty_lookup()
digrc (open)
main parsing -d
main parsing @ns.dnslab.se
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
main parsing dnslab.se
clone_lookup()
make_empty_lookup()
clone_server_list()
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
looking up dnslab.se
main parsing +nssearch
dig_startup()
lock_lookup dighost.c:4270
success
start_lookup()
setup_lookup(0x55555560a5d8)
resetting lookup counter.
idn_textname: dnslab.se
using root origin
recursive query
AD query
add_question()
starting to render the message
add_opt()
done rendering
create query 0x7fffec014208 linked to lookup 0x55555560a5d8
create query 0x7fffec034478 linked to lookup 0x55555560a5d8
do_lookup()
send_udp(0x7fffec014208)
bringup_timer()
have local timeout of 1
working on lookup 0x55555560a5d8, query 0x7fffec014208
sockcount=1
recving with lookup=0x55555560a5d8, query=0x7fffec014208, sock=0x7fffec0566f0
recvcount=1
sending a request
unlock_lookup dighost.c:4272
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=0
before parse starts
after parse
in NSSEARCH code
following up dnslab.se
found NS set
found NS ns5.he.net
requeue_lookup()
clone_lookup()
make_empty_lookup()
before insertion, init@0x55555560a5d8 -> 0xffffffffffffffff, new@0x7fffec05b438 -> 0xffffffffffffffff
after insertion, init -> 0x55555560a5d8, new = 0x7fffec05b438, new -> (nil)
cancel_lookup()
check_if_done()
list full
clear_query(0x7fffec034478)
adding server ns5.he.net
make_server(2001:470:500::2)
make_server(216.66.80.18)
found NS set
found NS ns2.he.net
adding server ns2.he.net
make_server(2001:470:200::2)
make_server(216.218.131.2)
found NS set
found NS ns1.he.net
adding server ns1.he.net
make_server(2001:470:100::2)
make_server(216.218.130.2)
found NS set
found NS ns2.dnslab.se
adding server ns2.dnslab.se
make_server(2a02:750:9::2a0)
make_server(5.178.75.242)
found NS set
found NS ns3.he.net
adding server ns3.he.net
make_server(2001:470:300::2)
make_server(216.218.132.2)
found NS set
found NS ns.dnslab.se
adding server ns.dnslab.se
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
found NS set
found NS ns4.he.net
adding server ns4.he.net
make_server(2001:470:400::2)
make_server(216.66.1.2)
clear_query(0x7fffec014208)
sockcount=0
check_next_lookup(0x55555560a5d8)
try_clear_lookup(0x55555560a5d8)
destroy
freeing server 0x55555560ba28 belonging to 0x55555560a5d8
freeing server 0x55555560c258 belonging to 0x55555560a5d8
start_lookup()
setup_lookup(0x7fffec05b438)
idn_textname: dnslab.se
using root origin
AD query
add_question()
starting to render the message
add_opt()
done rendering
create query 0x7fffec014208 linked to lookup 0x7fffec05b438
create query 0x7fffec034478 linked to lookup 0x7fffec05b438
create query 0x7fffec0379e8 linked to lookup 0x7fffec05b438
create query 0x7fffec036088 linked to lookup 0x7fffec05b438
create query 0x7fffec0362d8 linked to lookup 0x7fffec05b438
create query 0x7fffec04d558 linked to lookup 0x7fffec05b438
create query 0x7fffec04d7a8 linked to lookup 0x7fffec05b438
create query 0x7fffec04d9f8 linked to lookup 0x7fffec05b438
create query 0x7fffec04dc48 linked to lookup 0x7fffec05b438
create query 0x7fffec04de98 linked to lookup 0x7fffec05b438
create query 0x7fffec04e0e8 linked to lookup 0x7fffec05b438
create query 0x7fffec04e338 linked to lookup 0x7fffec05b438
create query 0x7fffec04e588 linked to lookup 0x7fffec05b438
create query 0x7fffec04e7d8 linked to lookup 0x7fffec05b438
do_lookup()
send_udp(0x7fffec014208)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec014208
sockcount=1
recving with lookup=0x7fffec05b438, query=0x7fffec014208, sock=0x7fffec0566f0
recvcount=1
sending a request
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec034478)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec034478
sockcount=2
recving with lookup=0x7fffec05b438, query=0x7fffec034478, sock=0x7fffec058ae0
recvcount=2
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec0379e8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec0379e8
sockcount=3
recving with lookup=0x7fffec05b438, query=0x7fffec0379e8, sock=0x7fffec05a410
recvcount=3
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec036088)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec036088
sockcount=4
recving with lookup=0x7fffec05b438, query=0x7fffec036088, sock=0x7fffec05a7a0
recvcount=4
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec0362d8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec0362d8
sockcount=5
recving with lookup=0x7fffec05b438, query=0x7fffec0362d8, sock=0x7fffec056f80
recvcount=5
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d558)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d558
sockcount=6
recving with lookup=0x7fffec05b438, query=0x7fffec04d558, sock=0x7fffec057310
recvcount=6
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d7a8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d7a8
sockcount=7
recving with lookup=0x7fffec05b438, query=0x7fffec04d7a8, sock=0x7fffec0576a0
recvcount=7
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d9f8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d9f8
sockcount=8
recving with lookup=0x7fffec05b438, query=0x7fffec04d9f8, sock=0x7fffec057a30
recvcount=8
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=7
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2a02:750:9::2ab in 0 ms.
still pending.
clear_query(0x7fffec04d7a8)
sockcount=7
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04dc48)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04dc48
sockcount=8
recving with lookup=0x7fffec05b438, query=0x7fffec04dc48, sock=0x7fffec0576a0
recvcount=8
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04de98)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04de98
sockcount=9
recving with lookup=0x7fffec05b438, query=0x7fffec04de98, sock=0x7fffec059790
recvcount=9
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=8
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2a02:750:9::2a0 in 0 ms.
still pending.
clear_query(0x7fffec04dc48)
sockcount=8
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04e0e8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04e0e8
sockcount=9
recving with lookup=0x7fffec05b438, query=0x7fffec04e0e8, sock=0x7fffec0576a0
recvcount=9
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04e338)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04e338
sockcount=10
recving with lookup=0x7fffec05b438, query=0x7fffec04e338, sock=0x7fffec058480
recvcount=10
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=9
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 5.178.75.76 in 0 ms.
still pending.
clear_query(0x7fffec04e0e8)
sockcount=9
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04e588)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04e588
sockcount=10
recving with lookup=0x7fffec05b438, query=0x7fffec04e588, sock=0x7fffec0576a0
recvcount=10
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=9
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 5.178.75.242 in 4 ms.
still pending.
clear_query(0x7fffec04e338)
sockcount=9
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04e7d8)
bringup_timer()
have local timeout of 5
working on lookup 0x7fffec05b438, query 0x7fffec04e7d8
sockcount=10
recving with lookup=0x7fffec05b438, query=0x7fffec04e7d8, sock=0x7fffec058480
recvcount=10
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=9
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.66.80.18 in 20 ms.
still pending.
clear_query(0x7fffec014208)
sockcount=9
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=8
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.66.1.2 in 16 ms.
still pending.
clear_query(0x7fffec0379e8)
sockcount=8
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=7
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.132.2 in 20 ms.
still pending.
clear_query(0x7fffec036088)
sockcount=7
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=6
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:300::2 in 20 ms.
still pending.
clear_query(0x7fffec04d9f8)
sockcount=6
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=5
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.131.2 in 24 ms.
still pending.
clear_query(0x7fffec0362d8)
sockcount=5
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=4
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.130.2 in 28 ms.
still pending.
clear_query(0x7fffec034478)
sockcount=4
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=3
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:100::2 in 24 ms.
still pending.
clear_query(0x7fffec04d558)
sockcount=3
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=2
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:400::2 in 16 ms.
still pending.
clear_query(0x7fffec04e7d8)
sockcount=2
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=1
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:500::2 in 24 ms.
still pending.
clear_query(0x7fffec04de98)
sockcount=1
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=0
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:200::2 in 24 ms.
still pending.
clear_query(0x7fffec04e588)
sockcount=0
check_next_lookup(0x7fffec05b438)
try_clear_lookup(0x7fffec05b438)
destroy
freeing server 0x7fffec035748 belonging to 0x7fffec05b438
freeing server 0x7fffec038578 belonging to 0x7fffec05b438
freeing server 0x7fffec03cd18 belonging to 0x7fffec05b438
freeing server 0x7fffec03a638 belonging to 0x7fffec05b438
freeing server 0x7fffec036ef8 belonging to 0x7fffec05b438
freeing server 0x7fffec037d48 belonging to 0x7fffec05b438
freeing server 0x7fffec03ae68 belonging to 0x7fffec05b438
freeing server 0x7fffec039e08 belonging to 0x7fffec05b438
freeing server 0x7fffec038da8 belonging to 0x7fffec05b438
freeing server 0x7fffec034f18 belonging to 0x7fffec05b438
freeing server 0x7fffec03b698 belonging to 0x7fffec05b438
freeing server 0x7fffec0395d8 belonging to 0x7fffec05b438
freeing server 0x7fffec0366c8 belonging to 0x7fffec05b438
freeing server 0x7fffec03c4e8 belonging to 0x7fffec05b438
start_lookup()
check_if_done()
list empty
shutting down
unlock_lookup dighost.c:4164
destroy
freeing server 0x555555609578 belonging to 0x555555606d38
freeing server 0x555555609da8 belonging to 0x555555606d38
cancel_all()
lock_lookup dighost.c:4286
success
unlock_lookup dighost.c:4324
destroy_libs()
freeing task
freeing taskmgr
lock_lookup dighost.c:4350
success
flush_server_list()
freeing socketmgr
[Thread 0x7ffff4fce700 (LWP 42743) exited]
freeing timermgr
[Thread 0x7ffff3fa2700 (LWP 42745) exited]
destroy DST lib
unlock_lookup dighost.c:4392
Removing log context
Destroy memory
[Thread 0x7ffff47cd700 (LWP 42744) exited]
[Inferior 1 (process 42739) exited normally]
No stack.
No stack.
Failed
root@d01:~# gdb -batch -n -ex 'set pagination off' -ex run -ex bt -ex 'bt full' -ex 'thread apply all bt full' --args dig -d @ns.dnslab.se dnslab.se +nssearch
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
setup_libs()
[New Thread 0x7ffff4fce700 (LWP 42756)]
[New Thread 0x7ffff47cd700 (LWP 42757)]
[New Thread 0x7ffff3fa2700 (LWP 42758)]
setup_system()
create_search_list()
ndots is 1.
get_server_list()
make_server(::1)
dig_query_setup
parse_args()
making new lookup
make_empty_lookup()
digrc (open)
main parsing -d
main parsing @ns.dnslab.se
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
main parsing dnslab.se
clone_lookup()
make_empty_lookup()
clone_server_list()
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
looking up dnslab.se
main parsing +nssearch
dig_startup()
lock_lookup dighost.c:4270
success
start_lookup()
setup_lookup(0x55555560a5d8)
resetting lookup counter.
idn_textname: dnslab.se
using root origin
recursive query
AD query
add_question()
starting to render the message
add_opt()
done rendering
create query 0x7fffec014208 linked to lookup 0x55555560a5d8
create query 0x7fffec034478 linked to lookup 0x55555560a5d8
do_lookup()
send_udp(0x7fffec014208)
bringup_timer()
have local timeout of 1
working on lookup 0x55555560a5d8, query 0x7fffec014208
sockcount=1
recving with lookup=0x55555560a5d8, query=0x7fffec014208, sock=0x7fffec0566f0
recvcount=1
sending a request
unlock_lookup dighost.c:4272
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=0
before parse starts
after parse
in NSSEARCH code
following up dnslab.se
found NS set
found NS ns5.he.net
requeue_lookup()
clone_lookup()
make_empty_lookup()
before insertion, init@0x55555560a5d8 -> 0xffffffffffffffff, new@0x7fffec05b438 -> 0xffffffffffffffff
after insertion, init -> 0x55555560a5d8, new = 0x7fffec05b438, new -> (nil)
cancel_lookup()
check_if_done()
list full
clear_query(0x7fffec034478)
adding server ns5.he.net
make_server(2001:470:500::2)
make_server(216.66.80.18)
found NS set
found NS ns1.he.net
adding server ns1.he.net
make_server(2001:470:100::2)
make_server(216.218.130.2)
found NS set
found NS ns4.he.net
adding server ns4.he.net
make_server(2001:470:400::2)
make_server(216.66.1.2)
found NS set
found NS ns.dnslab.se
adding server ns.dnslab.se
make_server(2a02:750:9::2ab)
make_server(5.178.75.76)
found NS set
found NS ns2.he.net
adding server ns2.he.net
make_server(2001:470:200::2)
make_server(216.218.131.2)
found NS set
found NS ns3.he.net
adding server ns3.he.net
make_server(2001:470:300::2)
make_server(216.218.132.2)
found NS set
found NS ns2.dnslab.se
adding server ns2.dnslab.se
make_server(2a02:750:9::2a0)
make_server(5.178.75.242)
clear_query(0x7fffec014208)
sockcount=0
check_next_lookup(0x55555560a5d8)
try_clear_lookup(0x55555560a5d8)
destroy
freeing server 0x55555560ba28 belonging to 0x55555560a5d8
freeing server 0x55555560c258 belonging to 0x55555560a5d8
start_lookup()
setup_lookup(0x7fffec05b438)
idn_textname: dnslab.se
using root origin
AD query
add_question()
starting to render the message
add_opt()
done rendering
create query 0x7fffec014208 linked to lookup 0x7fffec05b438
create query 0x7fffec034478 linked to lookup 0x7fffec05b438
create query 0x7fffec0379e8 linked to lookup 0x7fffec05b438
create query 0x7fffec036088 linked to lookup 0x7fffec05b438
create query 0x7fffec0362d8 linked to lookup 0x7fffec05b438
create query 0x7fffec04d558 linked to lookup 0x7fffec05b438
create query 0x7fffec04d7a8 linked to lookup 0x7fffec05b438
create query 0x7fffec04d9f8 linked to lookup 0x7fffec05b438
create query 0x7fffec04dc48 linked to lookup 0x7fffec05b438
create query 0x7fffec04de98 linked to lookup 0x7fffec05b438
create query 0x7fffec04e0e8 linked to lookup 0x7fffec05b438
create query 0x7fffec04e338 linked to lookup 0x7fffec05b438
create query 0x7fffec04e588 linked to lookup 0x7fffec05b438
create query 0x7fffec04e7d8 linked to lookup 0x7fffec05b438
do_lookup()
send_udp(0x7fffec014208)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec014208
sockcount=1
recving with lookup=0x7fffec05b438, query=0x7fffec014208, sock=0x7fffec0566f0
recvcount=1
sending a request
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec034478)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec034478
sockcount=2
recving with lookup=0x7fffec05b438, query=0x7fffec034478, sock=0x7fffec058ae0
recvcount=2
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec0379e8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec0379e8
sockcount=3
recving with lookup=0x7fffec05b438, query=0x7fffec0379e8, sock=0x7fffec05a410
recvcount=3
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec036088)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec036088
sockcount=4
recving with lookup=0x7fffec05b438, query=0x7fffec036088, sock=0x7fffec05a7a0
recvcount=4
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec0362d8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec0362d8
sockcount=5
recving with lookup=0x7fffec05b438, query=0x7fffec0362d8, sock=0x7fffec056f80
recvcount=5
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d558)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d558
sockcount=6
recving with lookup=0x7fffec05b438, query=0x7fffec04d558, sock=0x7fffec057310
recvcount=6
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d7a8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d7a8
sockcount=7
recving with lookup=0x7fffec05b438, query=0x7fffec04d7a8, sock=0x7fffec0576a0
recvcount=7
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04d9f8)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04d9f8
sockcount=8
recving with lookup=0x7fffec05b438, query=0x7fffec04d9f8, sock=0x7fffec057a30
recvcount=8
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04dc48)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04dc48
sockcount=9
recving with lookup=0x7fffec05b438, query=0x7fffec04dc48, sock=0x7fffec04ec30
recvcount=9
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
sending next, since searching
send_udp(0x7fffec04de98)
bringup_timer()
have local timeout of 1
working on lookup 0x7fffec05b438, query 0x7fffec04de98
sockcount=10
recving with lookup=0x7fffec05b438, query=0x7fffec04de98, sock=0x7fffec04efc0
recvcount=10
sending a request
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=9
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2a02:750:9::2ab in 0 ms.
still pending.
clear_query(0x7fffec036088)
sockcount=9
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=8
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 5.178.75.242 in 0 ms.
still pending.
clear_query(0x7fffec04de98)
sockcount=8
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
lock_lookup dighost.c:2609
success
send_done()
sendcount=0
check_if_done()
list empty
unlock_lookup dighost.c:2638
recv_done()
lock_lookup dighost.c:3620
success
recvcount=7
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:200::2 in 16 ms.
still pending.
clear_query(0x7fffec0379e8)
sockcount=7
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=6
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.130.2 in 16 ms.
still pending.
clear_query(0x7fffec04d9f8)
sockcount=6
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=5
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:100::2 in 16 ms.
still pending.
clear_query(0x7fffec04d7a8)
sockcount=5
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=4
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:500::2 in 16 ms.
still pending.
clear_query(0x7fffec04dc48)
sockcount=4
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=3
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 2001:470:400::2 in 24 ms.
still pending.
clear_query(0x7fffec014208)
sockcount=3
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=2
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.131.2 in 24 ms.
still pending.
clear_query(0x7fffec034478)
sockcount=2
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=1
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.66.1.2 in 24 ms.
still pending.
clear_query(0x7fffec0362d8)
sockcount=1
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
recv_done()
lock_lookup dighost.c:3620
success
recvcount=0
before parse starts
after parse
in NSSEARCH code
printmessage(headers nocomments short_form)
SOA ns.dnslab.se. leffeg65.gmail.com. 2022041125 14400 3600 3628800 3600 from server 216.218.132.2 in 24 ms.
still pending.
clear_query(0x7fffec04d558)
sockcount=0
check_next_lookup(0x7fffec05b438)
still have a worker
unlock_lookup dighost.c:4164
^Cdestroy
freeing server 0x555555609578 belonging to 0x555555606d38
freeing server 0x555555609da8 belonging to 0x555555606d38
cancel_all()
lock_lookup dighost.c:4286
success
canceling pending query 0x7fffec04e0e8, belonging to 0x7fffec05b438
clear_query(0x7fffec04e0e8)
canceling pending query 0x7fffec04e338, belonging to 0x7fffec05b438
clear_query(0x7fffec04e338)
canceling pending query 0x7fffec04e588, belonging to 0x7fffec05b438
clear_query(0x7fffec04e588)
canceling pending query 0x7fffec04e7d8, belonging to 0x7fffec05b438
clear_query(0x7fffec04e7d8)
unlock_lookup dighost.c:4324
destroy_libs()
freeing task
freeing taskmgr
lock_lookup dighost.c:4350
success
[Thread 0x7ffff4fce700 (LWP 42756) exited]
dighost.c:4356: INSIST(current_lookup == ((void *)0)) failed, back trace
#0 0x7ffff7cc99b7 in ??
#1 0x7ffff7cc990a in ??
#2 0x55555556b275 in ??
#3 0x55555556080a in ??
#4 0x55555555af5c in ??
#5 0x7ffff7acad0a in ??
#6 0x55555555af9a in ??
Thread 1 "dig" received signal SIGABRT, Aborted.
__GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
50 ../sysdeps/unix/sysv/linux/raise.c: No such file or directory.
#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
#1 0x00007ffff7ac9537 in __GI_abort () at abort.c:79
#2 0x00007ffff7cc990f in isc_assertion_failed () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
#3 0x000055555556b275 in destroy_libs ()
#4 0x000055555556080a in dig_shutdown ()
#5 0x000055555555af5c in main ()
#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
set = {__val = {16387, 0, 201, 140737349083801, 201, 140737348766653, 140737488347936, 140737349496708, 140737488347936, 1, 140737350350403, 140737349496708, 2, 140737349496708, 140737350350403, 1}}
pid = <optimized out>
tid = <optimized out>
ret = <optimized out>
#1 0x00007ffff7ac9537 in __GI_abort () at abort.c:79
save_stage = 1
act = {__sigaction_handler = {sa_handler = 0x1, sa_sigaction = 0x1}, sa_mask = {__val = {140737349496687, 10, 26, 93824992579424, 140737351107176, 446, 3642780803204779520, 93824992571888, 93824992567752, 93824992567728, 312, 93824992571888, 3642780803204779520, 448, 0, 93824992364352}}, sa_flags = 5, sa_restorer = 0x7fffffffe588}
sigs = {__val = {32, 0 <repeats 15 times>}}
#2 0x00007ffff7cc990f in isc_assertion_failed () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#3 0x000055555556b275 in destroy_libs ()
No symbol table info available.
#4 0x000055555556080a in dig_shutdown ()
No symbol table info available.
#5 0x000055555555af5c in main ()
No symbol table info available.
Thread 4 (Thread 0x7ffff3fa2700 (LWP 42758) "isc-socket-0"):
#0 0x00007ffff7ba2116 in epoll_wait (epfd=11, events=0x5555555ffb40, maxevents=2048, timeout=-1) at ../sysdeps/unix/sysv/linux/epoll_wait.c:30
No locals.
#1 0x00007ffff7d0a844 in ?? () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#2 0x00007ffff7cfeec6 in isc.trampoline_run () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#3 0x00007ffff7c71ea7 in start_thread (arg=<optimized out>) at pthread_create.c:477
ret = <optimized out>
pd = <optimized out>
unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140737286645504, 5045960648599351544, 140737488346654, 140737488346655, 140737286643328, 8396800, -5045934229245054728, -5045942569989099272}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
not_first_call = 0
#4 0x00007ffff7ba1def in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
No locals.
Thread 3 (Thread 0x7ffff47cd700 (LWP 42757) "isc-timer"):
#0 futex_wait_cancelable (private=0, expected=0, futex_word=0x5555555a4fac) at ../sysdeps/nptl/futex-internal.h:186
__ret = -512
oldtype = 0
err = <optimized out>
oldtype = <optimized out>
err = <optimized out>
__ret = <optimized out>
resultvar = <optimized out>
__arg4 = <optimized out>
__arg3 = <optimized out>
__arg2 = <optimized out>
__arg1 = <optimized out>
_a4 = <optimized out>
_a3 = <optimized out>
_a2 = <optimized out>
_a1 = <optimized out>
#1 __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x5555555a4f30, cond=0x5555555a4f80) at pthread_cond_wait.c:508
spin = 0
buffer = {__routine = 0x7ffff7c78540 <__condvar_cleanup_waiting>, __arg = 0x7ffff47cccc0, __canceltype = 0, __prev = 0x0}
cbuffer = {wseq = 15, cond = 0x5555555a4f80, mutex = 0x5555555a4f30, private = 0}
err = <optimized out>
g = 4101819552
flags = <optimized out>
g1_start = <optimized out>
maxspin = 0
signals = <optimized out>
result = 0
wseq = 15
seq = 7
private = 0
maxspin = <optimized out>
err = <optimized out>
result = <optimized out>
wseq = <optimized out>
g = <optimized out>
seq = <optimized out>
flags = <optimized out>
private = <optimized out>
signals = <optimized out>
done = <optimized out>
g1_start = <optimized out>
spin = <optimized out>
buffer = {__routine = <optimized out>, __arg = <optimized out>, __canceltype = <optimized out>, __prev = <optimized out>}
cbuffer = {wseq = <optimized out>, cond = <optimized out>, mutex = <optimized out>, private = <optimized out>}
s = <optimized out>
#2 __pthread_cond_wait (cond=0x5555555a4f80, mutex=0x5555555a4f30) at pthread_cond_wait.c:638
No locals.
#3 0x00007ffff7d00d88 in ?? () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#4 0x00007ffff7cfeec6 in isc.trampoline_run () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#5 0x00007ffff7c71ea7 in start_thread (arg=<optimized out>) at pthread_create.c:477
ret = <optimized out>
pd = <optimized out>
unwind_buf = {cancel_jmp_buf = {{jmp_buf = {140737295210240, 5045960648599351544, 140737488347614, 140737488347615, 140737295208064, 8396800, -5045946381318147848, -5045942569989099272}, mask_was_saved = 0}}, priv = {pad = {0x0, 0x0, 0x0, 0x0}, data = {prev = 0x0, cleanup = 0x0, canceltype = 0}}}
not_first_call = 0
#6 0x00007ffff7ba1def in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
No locals.
Thread 1 (Thread 0x7ffff5110880 (LWP 42752) "dig"):
#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
set = {__val = {16387, 0, 201, 140737349083801, 201, 140737348766653, 140737488347936, 140737349496708, 140737488347936, 1, 140737350350403, 140737349496708, 2, 140737349496708, 140737350350403, 1}}
pid = <optimized out>
tid = <optimized out>
ret = <optimized out>
#1 0x00007ffff7ac9537 in __GI_abort () at abort.c:79
save_stage = 1
act = {__sigaction_handler = {sa_handler = 0x1, sa_sigaction = 0x1}, sa_mask = {__val = {140737349496687, 10, 26, 93824992579424, 140737351107176, 446, 3642780803204779520, 93824992571888, 93824992567752, 93824992567728, 312, 93824992571888, 3642780803204779520, 448, 0, 93824992364352}}, sa_flags = 5, sa_restorer = 0x7fffffffe588}
sigs = {__val = {32, 0 <repeats 15 times>}}
#2 0x00007ffff7cc990f in isc_assertion_failed () from /lib/x86_64-linux-gnu/libisc-9.16.27-Debian.so
No symbol table info available.
#3 0x000055555556b275 in destroy_libs ()
No symbol table info available.
#4 0x000055555556080a in dig_shutdown ()
No symbol table info available.
#5 0x000055555555af5c in main ()
No symbol table info available.