Opened 12 years ago

Last modified 7 years ago

#396 closed defect (Fixed)

r9628 crashing when trying to test if 387 was fixed

Reported by: seeess Owned by:
Priority: High Milestone: 0.1.2.x-final
Component: Core Tor/Tor Version: 0.1.2.7-alpha
Severity: Keywords:
Cc: seeess Actual Points:
Parent ID: Points:
Reviewer: Sponsor:

Description

tested r9628, two different crashes, probably related but one threw an assert
getting these filed in flyspray cause nickm requested it, tomorrow i'll to more testing,
see if newer revisions helped or if older ones dont crash

from log
Feb 23 21:46:34.236 [info] connection_dir_client_reached_eof(): Received directory (size 17626) from server '129.21.x.x:9030'
Feb 23 21:46:37.756 [info] connection_edge_reached_eof(): conn (fd 27) reached eof. Closing.
Feb 23 21:46:37.757 [info] connection_edge_reached_eof(): conn (fd 25) reached eof. Closing.
Feb 23 21:46:37.770 [info] connection_edge_process_relay_cell(): 28: end cell (closed normally) for stream 12893. Removing stream.
Feb 23 21:46:37.771 [info] connection_edge_process_relay_cell(): 26: end cell (closed normally) for stream 12892. Removing stream.
Feb 23 21:46:55.367 [info] consider_testing_reachability(): Testing reachability of my ORPort: 129.21.x.x:9001.
Feb 23 21:46:55.368 [info] onion_pick_cpath_exit(): Using requested exit node 'tehonionrouter'
Feb 23 21:46:55.368 [info] compute_preferred_testing_list(): Looking for middle server that doesn't have the reachability bug, and chose 'hppie'. Great.
Feb 23 21:46:55.381 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'fuckchop'

(gdb) bt
#0 0xb7f55410 in ?? ()
#1 0xbf847868 in ?? ()
#2 0x00000006 in ?? ()
#3 0x00003175 in ?? ()
#4 0xb7cb4651 in raise () from /lib/libc.so.6
#5 0xb7cb5ca9 in abort () from /lib/libc.so.6
#6 0xb7ce93ab in fsetlocking () from /lib/libc.so.6
#7 0xb7ceeda0 in malloc_usable_size () from /lib/libc.so.6
#8 0xb7cf03e4 in free () from /lib/libc.so.6
#9 0x08085f67 in clear_cached_dir (d=0xb7da5ff4) at dirserv.c:1018
#10 0x08085fd7 in cached_dir_decref (d=0x82ef710) at dirserv.c:993
#11 0x08086038 in dirserv_clear_old_v1_info (now=1172285215) at dirserv.c:1155
#12 0x0809493d in second_elapsed_callback (fd=-1, event=1, args=0x0)

at main.c:887

#13 0xb7dae332 in event_base_loop () from /usr/lib/libevent-1.1a.so.1
#14 0xb7dae549 in event_loop () from /usr/lib/libevent-1.1a.so.1
#15 0xb7dae56e in event_dispatch () from /usr/lib/libevent-1.1a.so.1
#16 0x08095537 in tor_main (argc=3, argv=0xbf8485a4) at main.c:1261
#17 0x080b8c22 in main (argc=Cannot access memory at address 0x3175
) at tor_main.c:22

===========================================================================

from log
Feb 23 21:52:34.166 [info] connection_edge_reached_eof(): conn (fd 27) reached eof. Closing.
Feb 23 21:52:34.177 [info] connection_edge_process_relay_cell(): 26: end cell (closed normally) for stream 23297. Removing stream.
Feb 23 21:52:35.617 [info] consider_testing_reachability(): Testing reachability of my ORPort: 129.21.x.x:9001.
Feb 23 21:52:35.617 [info] onion_pick_cpath_exit(): Using requested exit node 'tehonionrouter'
Feb 23 21:52:35.618 [info] compute_preferred_testing_list(): Looking for middle server that doesn't have the reachability bug, and chose 'hppie'. Great.
Feb 23 21:52:35.631 [info] circuit_send_next_onion_skin(): First hop: finished sending CREATE cell to 'MrServer'
Feb 23 21:52:35.631 [info] routerstatus_list_update_from_networkstatus(): Rebuilding router status list.
Feb 23 21:52:35.634 [err] buffers.c:1441: assert_buf_ok: Assertion u32 == END_MAGIC failed; aborting.

#0 0xb7f9b410 in ?? ()
#1 0xbfe186dc in ?? ()
#2 0x00000006 in ?? ()
#3 0x00003209 in ?? ()
#4 0xb7cfa651 in raise () from /lib/libc.so.6
#5 0xb7cfbca9 in abort () from /lib/libc.so.6
#6 0x0804c9d1 in assert_buf_ok (buf=0x82d8d80) at buffers.c:1432
#7 0x080677d7 in assert_connection_ok (conn=0x81653c8, now=1172285555)

at connection.c:2403

#8 0x080957ef in conn_write_callback (fd=30, events=4, _conn=0x81653c8)

at main.c:453

#9 0xb7df4332 in event_base_loop () from /usr/lib/libevent-1.1a.so.1
#10 0xb7df4549 in event_loop () from /usr/lib/libevent-1.1a.so.1
#11 0xb7df456e in event_dispatch () from /usr/lib/libevent-1.1a.so.1
#12 0x08095537 in tor_main (argc=3, argv=0xbfe18b64) at main.c:1261
#13 0x080b8c22 in main (argc=Cannot access memory at address 0x3209
) at tor_main.c:22

[Automatically added by flyspray2trac: Operating System: Other Linux]

Child Tickets

Change History (8)

comment:1 Changed 12 years ago by seeess

Linux x 2.6.18-gentoo-r3 #2 Sat Nov 25 16:26:26 EST 2006 i686 Pentium III (Katmai) GenuineIntel GNU/Linux

egrep '^[^#]' /usr/local/etc/tor/torrc

SocksPort 9050 # what port to open for local application connections
SocksListenAddress x.x.x.x# accept connections only from localhost
Log info file /var/log/tor/tor.log
DataDirectory /var/lib/tor/data/
ControlPort 9051
HiddenServiceDir /var/lib/tor/data/hidden_service/
HiddenServicePort 80 x:80
Nickname tehonionrouter
Address w.x.y.z
ContactInfo irc:seeess
ORPort 9001
DirPort 9030 # what port to advertise for directory connections
ExitPolicy accept w.x.0.0/16:9030
ExitPolicy reject *:* # no exits allowed
RendPostPeriod 5 minutes
AuthoritativeDirectory 1
RecommendedVersions 0.1.2.4-alpha-dev,0.1.2.5-alpha,0.1.2.6-alpha
VersioningAuthoritativeDirectory 1
AuthDirRejectUnlisted 1
HSAuthoritativeDir 1
EnforceDistinctSubnets 0
NamingAuthoritativeDirectory 1
CircuitBuildTimeout 10
LongLivedPorts 8080
DirServer x hs x.x.x.x:9030 x
DirServer x hs x.x.x.x:9030 x
DirServer x hs x.x.x.x:9030 x
DirServer x hs x.x.x.x:9030 x
DirServer x hs x.x.x.x:9030 x

comment:2 Changed 12 years ago by seeess

9571 works... 9572 crashes

comment:3 Changed 12 years ago by nickm

I think I just checked in a fix for this (r9648). Can you try out svn HEAD and see whether it's any better for you?

comment:4 Changed 12 years ago by seeess

It doesnt crash anymore but if I keep refreshing http://ip:9030 eventually (something like 1/10) I'll get the old cached v1 directory. I tried it in IE (which wouldn't have a local cache of it) and it works, I've tried it holding down ctrl-f5 when refreshing with the same results. Also tried using a browser on another box with the same results.

No real hints in the log, should I change my log level?

Feb 24 22:19:14.844 [notice] Client asked for the mirrored directory, but we don't have a good one yet. Sending 503 Dir not available.
Feb 24 22:19:14.844 [info] router_pick_trusteddirserver(): No trusted dirservers are reachable. Trying them all again.
Feb 24 22:19:14.849 [info] connection_dir_client_reached_eof(): Received directory (size 17626) from server '129.21.x.x:9030'
Feb 24 22:19:17.289 [notice] Client asked for the mirrored directory, but we don't have a good one yet. Sending 503 Dir not available.
Feb 24 22:19:17.289 [info] router_pick_trusteddirserver(): No trusted dirservers are reachable. Trying them all again.
Feb 24 22:19:17.293 [info] connection_dir_client_reached_eof(): Received directory (size 17626) from server '129.21.x.x:9030'
Feb 24 22:19:18.410 [notice] Client asked for the mirrored directory, but we don't have a good one yet. Sending 503 Dir not available.
Feb 24 22:19:18.410 [info] router_pick_trusteddirserver(): No trusted dirservers are reachable. Trying them all again.
Feb 24 22:19:18.417 [info] connection_dir_client_reached_eof(): Received directory (size 17626) from server '129.21.x.x:9030'

comment:5 Changed 12 years ago by arma

r9649 may address this.

comment:6 Changed 12 years ago by seeess

race condition fixed in 9649, solved as far as I'm concerned

comment:7 Changed 12 years ago by nickm

flyspray2trac: bug closed.
Seems to have been fixed in r9649.

comment:8 Changed 7 years ago by nickm

Component: Tor RelayTor
Note: See TracTickets for help on using tickets.