[tor-bugs] #27750 [Core Tor/Tor]: conn_close_if_marked: Non-fatal assertion !(connection_is_writing(conn))

Tor Bug Tracker & Wiki blackhole at torproject.org
Sat Oct 20 09:39:27 UTC 2018


#27750: conn_close_if_marked: Non-fatal assertion !(connection_is_writing(conn))
------------------------------------------+--------------------------------
 Reporter:  dgoulet                       |          Owner:  dgoulet
     Type:  defect                        |         Status:
                                          |  needs_information
 Priority:  Very High                     |      Milestone:  Tor:
                                          |  0.3.5.x-final
Component:  Core Tor/Tor                  |        Version:  Tor: 0.3.4.8
 Severity:  Normal                        |     Resolution:
 Keywords:  regression, assert, 035-must  |  Actual Points:
Parent ID:                                |         Points:
 Reviewer:                                |        Sponsor:
------------------------------------------+--------------------------------

Comment (by udo):

 We still see some bug:


 {{{
 Oct 20 04:05:03.000 [notice] New control connection opened from 127.0.0.1.
 Oct 20 04:10:03.000 [notice] New control connection opened from 127.0.0.1.
 Oct 20 04:12:32.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:32.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:40.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:47.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:12:55.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:13.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] tor_bug_occurred_(): Bug:
 src/core/mainloop/mainloop.c:1022: conn_close_if_marked: Non-fatal
 assertion !(connection_is_reading(conn)) failed. (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug: Non-fatal assertion
 !(connection_is_reading(conn)) failed in conn_close_if_marked at
 src/core/mainloop/mainloop.c:1022. Stack trace: (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(log_backtrace_impl+0x46)
 [0x561eb63d4636] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_bug_occurred_+0xc0)
 [0x561eb63cfd30] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(+0x68d25)
 [0x561eb624dd25] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /lib64/libevent-2.1.so.6(+0x235b1)
 [0x7ff1c8dcf5b1] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:
 /lib64/libevent-2.1.so.6(event_base_loop+0x537) [0x7ff1c8dcfd47] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(do_main_loop+0xb0)
 [0x561eb624f780] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_run_main+0x147f)
 [0x561eb623d56f] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(tor_main+0x3a)
 [0x561eb623a7da] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(main+0x19)
 [0x561eb623a399] (on Tor 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:
 /lib64/libc.so.6(__libc_start_main+0xeb) [0x7ff1c734d11b] (on Tor
 0.3.5.3-alpha )
 Oct 20 04:13:14.000 [warn] Bug:     /usr/bin/tor(_start+0x2a)
 [0x561eb623a3ea] (on Tor 0.3.5.3-alpha )
 Oct 20 04:15:03.000 [notice] New control connection opened from 127.0.0.1.
 Oct 20 04:20:03.000 [notice] New control connection opened from 127.0.0.1.
 Oct 20 04:25:03.000 [notice] New control connection opened from 127.0.0.1.

 }}}

 (...)

 {{{
 Oct 20 04:58:54.000 [notice] Heartbeat: Tor's uptime is 18:00 hours, with
 595 circuits open. I've sent 16.60 GB and received 16.56 GB.
 Oct 20 04:58:54.000 [notice] Heartbeat: Accounting enabled. Sent: 15.51
 GB, Received: 15.47 GB, Used: 15.52 GB / 99.00 GB, Rule: max. The current
 accounting interval ends on 2018-10-20 12:21:00, in 7:22 hours.
 Oct 20 04:58:54.000 [notice] Circuit handshake stats since last time:
 1138/1138 TAP, 21372/21372 NTor.
 Oct 20 04:58:54.000 [notice] Since startup, we have initiated 0 v1
 connections, 0 v2 connections, 0 v3 connections, and 4988 v4 connections;
 and received 0 v1 connections, 298 v2 connections, 560 v3 connections, and
 6409 v4 connections.
 Oct 20 04:58:54.000 [notice] DoS mitigation since startup: 0 circuits
 killed with too many cells. 0 circuits rejected, 0 marked addresses. 0
 connections closed. 224 single hop clients refused.

 }}}

 So what does this tell us?
 Were we dealing with two issues? With one fixed now?

--
Ticket URL: <https://trac.torproject.org/projects/tor/ticket/27750#comment:19>
Tor Bug Tracker & Wiki <https://trac.torproject.org/>
The Tor Project: anonymity online


More information about the tor-bugs mailing list