silc-server 1.1.2 crash after key exchange timeout
Stuart Henderson
stu at spacehopper.org
Sat Apr 5 16:10:44 CEST 2008
not quite sure what happened with the server connecting to me,
but my backup router died after a key exchange timeout. bt and
-D 10 logging follows. Server 1.1.2, OpenBSD/sparc64.
14:57:05 silc_server_accept_new_connection:2691: Starting key exchange protocol
14:57:06 silc_server_accept_completed:2528: Setting keys into use
14:57:06 silc_server_accept_completed:2549: Starting connection authentication
14:57:06 silc_server_packet_parse_type:296: Received NEW SERVER packet [flags 0]
14:57:06 silc_server_new_server:2329: Creating new server
14:57:06 silc_server_new_server:2480: New server id(xx-server,49666,[00 ff])
14:57:09 silc_server_packet_parse_type:296: Received DISCONNECT packet [flags 0]
[Logging] [Info] Disconnected by xx-server (xx-server): (0) Server is shutting down
[Logging] [Info] Closing connection xx-server:34308 [Unknown]
14:57:09 silc_server_packet_parse_type:296: Received DISCONNECT packet [flags 0]
[Logging] [Info] Disconnected by xx-server (xx-server): (0) Server is shutting down
[Logging] [Info] Closing connection xx-server:37596 [Unknown]
14:57:10 silc_server_accept_get_auth:2037: Remote connection type 2
14:57:10 silc_server_accept_auth_compl:2150: Checking whether connection is allowed
14:57:10 silc_server_connection_allowed:1171: Checking whether connection is allowed
14:57:10 silc_server_accept_auth_compl:2375: Remote host is server
[Logging] [Info] Connection xx-server (xx-server) is server
14:57:10 silc_server_accept_auth_compl:2432: my_servers 5
14:57:10 silc_server_accept_auth_compl:2478: New connection 0x40d4dc80 authenticated
14:57:10 silc_server_config_destroy:1600: Unreferencing config [0x410b9c00] refcnt 9->8
14:57:10 silc_server_config_destroy:1600: Unreferencing config [0x410b9c00] refcnt 8->7
14:57:10 silc_server_packet_eos:197: End of stream received
14:57:10 silc_server_free_sock_user_data:3000: Start
14:57:10 silc_server_free_sock_user_data:3036: Freeing server 0x4c2a2100 data
14:57:10 silc_server_send_opers:1580: Sending NOTIFY packet to operators
14:57:10 silc_server_remove_servers_by_server:778: Removing servers by xx-server
14:57:10 silc_server_remove_clients_by_server:150: Removing clients by xx-server
14:57:10 silc_server_remove_clients_by_server:320: Sending SERVER_SIGNOFF for xx-server,49666,[00 ff] with 0 clients
14:57:10 silc_server_packet_send:47: Sending NOTIFY packet
14:57:10 silc_server_connection_free:1290: Free connection 0x40d4d680
14:57:10 silc_server_free_sock_user_data:3195: my_servers 4
[Logging] [Info] Closing connection xx-server:28162 []
14:57:16 silc_server_purge_expired_clients:1257: Expire timeout
14:57:42 silc_server_get_stats:5064: Retrieving stats from router
14:57:42 silc_server_packet_send:47: Sending COMMAND packet
14:57:42 silc_server_packet_parse_type:296: Received COMMAND REPLY packet [flags 0]
14:57:42 silc_server_command_reply:1860: Start
14:57:42 silc_server_command_reply_process:72: Start
14:57:42 silc_server_command_reply_stats:1215: Start
[Logging] [Error] Error (Key exchange timeout) during Key Exchange protocol with xx-server (xx-server)
14:58:06 silc_server_disconnect_remote:2899: Disconnecting remote host
[Logging] [Error] Connection xx-server:37596 [Unknown]: Cannot write to stream
[Logging] [Info] Closing connection xx-server:37596 [Unknown]
14:58:06 silc_server_free_sock_user_data:3000: Start
14:58:06 silc_server_free_sock_user_data:3233: Freeing unknown connection data
#0 pthread_mutex_lock (mutex=0x10000073)
at /usr/src/lib/libpthread/uthread/uthread_mutex.c:674
ret = 22
#1 0x000000000018b4fc in silc_mutex_lock (mutex=0x10000073)
at silcunixthread.c:147
No locals.
#2 0x0000000000176dcc in silc_packet_set_context (stream=0x44adbd00,
stream_context=0x0) at silcpacket.c:1185
No locals.
#3 0x0000000000121510 in silc_server_free_sock_user_data (server=0x4496c400,
sock=0x44adbd00, signoff_message=0x0) at server.c:3239
entry = 0x4c2a2300
idata = 0x4c2a2300
ip = 0x0
port = 0
#4 0x000000000011adec in silc_server_packet_error_timeout (
schedule=0x49225000, app_context=0x4496c400, type=SILC_TASK_EXPIRE, fd=0,
context=0x44adbd00) at server.c:242
server = 0x4496c400
stream = 0x44adbd00
idata = 0x4c2a2300
#5 0x0000000000198da8 in silc_schedule_dispatch_timeout (schedule=0x49225000,
dispatch_all=0 '\0') at silcschedule.c:114
t = 0x4d33e700
task = 0x4d33e700
curtime = {tv_sec = 1207403886, tv_usec = 10002}
count = 0
#6 0x00000000001994f4 in silc_schedule_select_timeout (schedule=0x49225000)
at silcschedule.c:159
t = 0x4d33e700
task = 0x4d33e700
curtime = {tv_sec = 1207403886, tv_usec = 9862}
dispatch = 1 '\001'
#7 0x0000000000199070 in silc_schedule_iterate (schedule=0x49225000,
timeout_usecs=-1) at silcschedule.c:424
timeout = {tv_sec = 4571965599140177420, tv_usec = 1295246528}
ret = 0
#8 0x00000000001965dc in silc_schedule (schedule=0x49225000)
at silcschedule.c:499
No locals.
#9 0x000000000011d630 in silc_server_run (server=0x4496c400) at server.c:1187
No locals.
#10 0x000000000010dc5c in main (argc=3, argv=0xffffffffffff1868) at silcd.c:753
ret = 1
opt = -1
option_index = 1060104
foreground = 1 '\001'
opt_create_keypair = 0 '\0'
silcd_config_file = 0x4164c020 "/etc/silcd/silcd.conf"
sa = {__sigaction_u = {__sa_handler = 0x1, __sa_sigaction = 0x1},
sa_mask = 0, sa_flags = 0}
More information about the silc-devel
mailing list