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