server shutdown -> not removed from routers, can't reconnect "too many regs"

Stuart Henderson <[email protected]> Tue, 11 Nov 2008 12:11:50 +0000 (UTC)
Newsgroups gmane.network.silc.devel
Message-ID <[email protected]>
network layout:

main server/router. (same silcd instance, address in logs shown with rrr)
couple of other servers. (address shown with sss, yyy)
backup router (dedicated, address shown with bbb).

the log below is -d*server*,*idlist* from the backup router.

the server (sss) shut down and disconnected from the router and
backup router; when it restarted it was unable to connect to either
the backup router or the router, error is "too many registrations".

note the "silc_idlist_del_server:258: Unknown server, did not delete"

yyy has shut down and reconnected with absolutely no problems.
this has happened with sss before, probably every time it restarted
actually, only remedy being to shutdown the routers.

any ideas?

yyy, rrr 1.1.14 on OpenBSD/amd64
bbb 1.1.13 on OpenBSD/sparc64
sss runs on OpenBSD/macppc, probably happened running various
version from at least 1.1.12 on, and maybe earlier

11:09:30 silc_server_get_stats:5295: Retrieving stats from router
11:09:30 silc_server_packet_send:47: Sending COMMAND packet
11:09:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:09:30 silc_server_command_reply:1866: Start
11:09:30 silc_server_command_reply_process:72: Start
11:09:30 silc_server_command_reply_stats:1220: Start
11:10:03 silc_server_purge_expired_clients:1268: Expire timeout
11:11:19 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:11:19 silc_server_notify_process:1521: UMODE_CHANGE notify
11:11:19 silc_idlist_find_client_by_id:511: Client ID (xx.xx.xx.xx,c5,[b4 b1 8c f8...])
11:11:19 silc_idlist_find_client_by_id:526: Found
11:11:19 silc_server_check_watcher_list:1645: Checking watcher list xxxxxxx
11:11:30 silc_server_get_stats:5295: Retrieving stats from router
11:11:30 silc_server_packet_send:47: Sending COMMAND packet
11:11:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:11:30 silc_server_command_reply:1866: Start
11:11:30 silc_server_command_reply_process:72: Start
11:11:30 silc_server_command_reply_stats:1220: Start
11:12:03 silc_server_purge_expired_clients:1268: Expire timeout
11:13:30 silc_server_get_stats:5295: Retrieving stats from router
11:13:30 silc_server_packet_send:47: Sending COMMAND packet
11:13:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:13:30 silc_server_command_reply:1866: Start
11:13:30 silc_server_command_reply_process:72: Start
11:13:30 silc_server_command_reply_stats:1220: Start
11:14:03 silc_server_purge_expired_clients:1268: Expire timeout
11:15:21 silc_server_do_rekey:2911: Perform rekey, sock 0x43226c00
11:15:21 silc_server_do_rekey:2927: Executing rekey protocol with rrr.rr.rr.r:706 [Router]
11:15:21 silc_server_rekey_completion:2892: Rekey protocol completed with rrr.rr.rr.r:706 [Router]
11:15:30 silc_server_get_stats:5295: Retrieving stats from router
11:15:30 silc_server_packet_send:47: Sending COMMAND packet
11:15:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:15:30 silc_server_command_reply:1866: Start
11:15:30 silc_server_command_reply_process:72: Start
11:15:30 silc_server_command_reply_stats:1220: Start
11:15:37 silc_server_packet_parse_type:307: Received DISCONNECT packet [flags 0]
[Logging] [Info] Disconnected by sss.ss.ss.ss (ssss.ss.ss.ss):  (0) Server is shutting down
11:15:37 silc_server_free_sock_user_data:3171: Start, sock 0x4e034e00
11:15:37 silc_server_free_sock_user_data:3209: Freeing server 0x4a7d8100 data
11:15:37 silc_server_send_opers:1625: Sending NOTIFY packet to operators
11:15:37 silc_server_remove_servers_by_server:782: Removing servers by ssss.ss.ss.ss
11:15:37 silc_server_remove_clients_by_server:150: Removing clients by ssss.ss.ss.ss
11:15:37 silc_server_remove_clients_by_server:324: Sending SERVER_SIGNOFF for sss.ss.ss.ss,49666,[00 ff] with 0 clients
11:15:37 silc_server_packet_send:47: Sending NOTIFY packet
11:15:37 silc_server_connection_free:1300: Free connection 0x4af67980
11:15:37 silc_server_free_sock_user_data:3370: my_servers 1
11:15:37 silc_idlist_del_server:265: Deleting server ssss.ss.ss.ss id sss.ss.ss.ss,49666,[00 ff]
[Logging] [Info] Closing connection ssss.ss.ss.ss:47401 []
11:15:37 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:15:37 silc_server_notify_process:1190: SERVER SIGNOFF notify
11:15:37 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:15:37 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:15:52 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:15:52 silc_server_new_id_real:2587: Processing new ID
11:15:52 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:15:52 silc_idlist_find_server_by_id:137: Found
11:15:52 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,e5,[8f 2d 68 1c...])
11:15:52 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,e5,[8f 2d 68 1c...])
11:15:52 silc_server_new_id_real:2665: New client id(yyy.yy.yyy.yy,e5,[8f 2d 68 1c...]) from [Router] rrrrrr.rrrrrrrr.rrr
11:15:52 silc_idlist_add_client:313: Adding new client entry
11:15:52 silc_server_packet_send:47: Sending COMMAND packet
11:15:52 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:15:52 silc_server_command_reply:1866: Start
11:15:52 silc_server_command_reply_process:72: Start
11:15:52 silc_server_command_reply_getkey:1354: Start
11:15:52 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,e5,[8f 2d 68 1c...])
11:15:52 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,e5,[8f 2d 68 1c...])
11:15:52 silc_idlist_find_client_by_id:526: Found
11:15:52 silc_server_get_public_key:1108: Start
11:15:52 silc_server_get_public_key:1123: Public key not found
11:15:52 silc_server_packet_parse_type:307: Received CHANNEL KEY packet [flags 0]
11:15:52 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:52 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
[Logging] [Error] Received key for non-existent channel rrr.rr.rr.r,49666,[23 e7]
[Logging] [Error] Bad channel key from rrr.rr.rr.r
11:15:53 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:15:53 silc_server_notify_process:138: JOIN notify
11:15:53 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:53 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:53 silc_server_notify_process:152: Notify for unknown channel rrr.rr.rr.r,49666,[23 e7]
11:15:53 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:15:53 silc_server_new_id_real:2587: Processing new ID
11:15:53 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:15:53 silc_idlist_find_server_by_id:137: Found
11:15:53 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,c7,[bd 27 5c e0...])
11:15:53 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,c7,[bd 27 5c e0...])
11:15:53 silc_server_new_id_real:2665: New client id(yyy.yy.yyy.yy,c7,[bd 27 5c e0...]) from [Router] rrrrrr.rrrrrrrr.rrr
11:15:53 silc_idlist_add_client:313: Adding new client entry
11:15:53 silc_server_packet_send:47: Sending COMMAND packet
11:15:53 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:15:53 silc_server_command_reply:1866: Start
11:15:53 silc_server_command_reply_process:72: Start
11:15:53 silc_server_command_reply_getkey:1354: Start
11:15:53 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,c7,[bd 27 5c e0...])
11:15:53 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,c7,[bd 27 5c e0...])
11:15:53 silc_idlist_find_client_by_id:526: Found
11:15:53 silc_server_get_public_key:1108: Start
11:15:53 silc_server_get_public_key:1123: Public key not found
11:15:53 silc_server_packet_parse_type:307: Received CHANNEL KEY packet [flags 0]
11:15:53 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:53 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
[Logging] [Error] Received key for non-existent channel rrr.rr.rr.r,49666,[23 e7]
[Logging] [Error] Bad channel key from rrr.rr.rr.r
11:15:54 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:15:54 silc_server_notify_process:138: JOIN notify
11:15:54 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:54 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:15:54 silc_server_notify_process:152: Notify for unknown channel rrr.rr.rr.r,49666,[23 e7]
11:15:55 silc_server_packet_parse_type:307: Received CHANNEL KEY packet [flags 0]
11:15:55 silc_idlist_find_channel_by_id:765: Channel ID (bbb.bb.bbb.bbb,49666,[bd f8])
11:15:55 silc_idlist_find_channel_by_id:765: Channel ID (bbb.bb.bbb.bbb,49666,[bd f8])
[Logging] [Error] Received key for non-existent channel bbb.bb.bbb.bbb,49666,[bd f8]
[Logging] [Error] Bad channel key from rrr.rr.rr.r
11:15:55 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:15:55 silc_server_notify_process:138: JOIN notify
11:15:55 silc_idlist_find_channel_by_id:765: Channel ID (bbb.bb.bbb.bbb,49666,[bd f8])
11:15:55 silc_idlist_find_channel_by_id:765: Channel ID (bbb.bb.bbb.bbb,49666,[bd f8])
11:15:55 silc_server_notify_process:152: Notify for unknown channel bbb.bb.bbb.bbb,49666,[bd f8]
11:16:03 silc_server_purge_expired_clients:1268: Expire timeout
11:16:21 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:16:21 silc_server_new_id_real:2587: Processing new ID
11:16:21 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:16:21 silc_idlist_find_server_by_id:137: Found
11:16:21 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:16:21 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:16:21 silc_server_new_id_real:2665: New client id(rrr.rr.rr.r,88,[9c e2 88 ec...]) from [Router] rrrrrr.rrrrrrrr.rrr
11:16:21 silc_idlist_add_client:313: Adding new client entry
11:16:21 silc_server_packet_send:47: Sending COMMAND packet
11:16:21 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:16:21 silc_server_command_reply:1866: Start
11:16:21 silc_server_command_reply_process:72: Start
11:16:21 silc_server_command_reply_getkey:1354: Start
11:16:21 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:16:21 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:16:21 silc_idlist_find_client_by_id:526: Found
11:16:21 silc_server_get_public_key:1108: Start
11:16:21 silc_server_get_public_key:1123: Public key not found
11:16:22 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:16:22 silc_server_notify_process:138: JOIN notify
11:16:22 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:16:22 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:16:22 silc_server_notify_process:152: Notify for unknown channel rrr.rr.rr.r,49666,[23 e7]
11:16:22 silc_server_packet_parse_type:307: Received CHANNEL KEY packet [flags 0]
11:16:22 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:16:22 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
[Logging] [Error] Received key for non-existent channel rrr.rr.rr.r,49666,[23 e7]
[Logging] [Error] Bad channel key from rrr.rr.rr.r
11:16:31 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:16:31 silc_server_new_id_real:2587: Processing new ID
11:16:31 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:16:31 silc_idlist_find_server_by_id:137: Found
11:16:31 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,dc,[fc 24 42 ec...])
11:16:31 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,dc,[fc 24 42 ec...])
11:16:31 silc_server_new_id_real:2665: New client id(rrr.rr.rr.r,dc,[fc 24 42 ec...]) from [Router] rrrrrr.rrrrrrrr.rrr
11:16:31 silc_idlist_add_client:313: Adding new client entry
11:16:31 silc_server_packet_send:47: Sending COMMAND packet
11:16:31 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:16:31 silc_server_command_reply:1866: Start
11:16:31 silc_server_command_reply_process:72: Start
11:16:31 silc_server_command_reply_getkey:1354: Start
11:16:31 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,dc,[fc 24 42 ec...])
11:16:31 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,dc,[fc 24 42 ec...])
11:16:31 silc_idlist_find_client_by_id:526: Found
11:16:31 silc_server_get_public_key:1108: Start
11:16:31 silc_server_get_public_key:1123: Public key not found
11:17:30 silc_server_get_stats:5295: Retrieving stats from router
11:17:30 silc_server_packet_send:47: Sending COMMAND packet
11:17:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:17:30 silc_server_command_reply:1866: Start
11:17:30 silc_server_command_reply_process:72: Start
11:17:30 silc_server_command_reply_stats:1220: Start
11:17:50 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:17:50 silc_server_notify_process:1521: UMODE_CHANGE notify
11:17:50 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:17:50 silc_idlist_find_client_by_id:526: Found
11:17:50 silc_server_check_watcher_list:1645: Checking watcher list
11:18:03 silc_server_purge_expired_clients:1268: Expire timeout
11:19:30 silc_server_get_stats:5295: Retrieving stats from router
11:19:30 silc_server_packet_send:47: Sending COMMAND packet
11:19:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:19:30 silc_server_command_reply:1866: Start
11:19:30 silc_server_command_reply_process:72: Start
11:19:30 silc_server_command_reply_stats:1220: Start
11:19:38 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:19:38 silc_server_new_id_real:2587: Processing new ID
11:19:38 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:19:38 silc_idlist_find_server_by_id:137: Found
11:19:38 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,ed,[bc 04 2a aa...])
11:19:38 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,ed,[bc 04 2a aa...])
11:19:38 silc_server_new_id_real:2665: New client id(yyy.yy.yyy.yy,ed,[bc 04 2a aa...]) from [Router] rrrrrr.rrrrrrrr.rrr
11:19:38 silc_idlist_add_client:313: Adding new client entry
11:19:38 silc_server_packet_send:47: Sending COMMAND packet
11:19:38 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:19:38 silc_server_command_reply:1866: Start
11:19:38 silc_server_command_reply_process:72: Start
11:19:38 silc_server_command_reply_getkey:1354: Start
11:19:38 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,ed,[bc 04 2a aa...])
11:19:38 silc_idlist_find_client_by_id:511: Client ID (yyy.yy.yyy.yy,ed,[bc 04 2a aa...])
11:19:38 silc_idlist_find_client_by_id:526: Found
11:19:38 silc_server_get_public_key:1108: Start
11:19:38 silc_server_get_public_key:1123: Public key not found
11:20:03 silc_server_purge_expired_clients:1268: Expire timeout
11:21:30 silc_server_get_stats:5295: Retrieving stats from router
11:21:30 silc_server_packet_send:47: Sending COMMAND packet
11:21:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:21:30 silc_server_command_reply:1866: Start
11:21:30 silc_server_command_reply_process:72: Start
11:21:30 silc_server_command_reply_stats:1220: Start
11:22:03 silc_server_purge_expired_clients:1268: Expire timeout
11:23:08 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:23:08 silc_server_notify_process:1521: UMODE_CHANGE notify
11:23:08 silc_idlist_find_client_by_id:511: Client ID (rrr.rr.rr.r,88,[9c e2 88 ec...])
11:23:08 silc_idlist_find_client_by_id:526: Found
11:23:08 silc_server_check_watcher_list:1645: Checking watcher list
11:23:30 silc_server_get_stats:5295: Retrieving stats from router
11:23:30 silc_server_packet_send:47: Sending COMMAND packet
11:23:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:23:30 silc_server_command_reply:1866: Start
11:23:30 silc_server_command_reply_process:72: Start
11:23:30 silc_server_command_reply_stats:1220: Start
11:24:03 silc_server_purge_expired_clients:1268: Expire timeout
11:24:12 silc_server_create_channel_key:3879: Generating channel #onrop key
11:24:12 silc_server_send_channel_key:1469: Sending key to channel #onrop
11:24:12 silc_server_packet_send_to_channel:318: Sending CHANNEL KEY to channel #onrop
11:24:56 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:24:56 silc_server_notify_process:1521: UMODE_CHANGE notify
11:24:56 silc_idlist_find_client_by_id:511: Client ID (xx.xx.xx.xx,c5,[b4 b1 8c f8...])
11:24:56 silc_idlist_find_client_by_id:526: Found
11:24:56 silc_server_check_watcher_list:1645: Checking watcher list xxxxxxx
11:25:30 silc_server_get_stats:5295: Retrieving stats from router
11:25:30 silc_server_packet_send:47: Sending COMMAND packet
11:25:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:25:30 silc_server_command_reply:1866: Start
11:25:30 silc_server_command_reply_process:72: Start
11:25:30 silc_server_command_reply_stats:1220: Start
11:25:58 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:25:58 silc_server_notify_process:138: JOIN notify
11:25:58 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:25:58 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:25:58 silc_server_notify_process:152: Notify for unknown channel rrr.rr.rr.r,49666,[23 e7]
11:25:58 silc_server_packet_parse_type:307: Received CHANNEL KEY packet [flags 0]
11:25:58 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
11:25:58 silc_idlist_find_channel_by_id:765: Channel ID (rrr.rr.rr.r,49666,[23 e7])
[Logging] [Error] Received key for non-existent channel rrr.rr.rr.r,49666,[23 e7]
[Logging] [Error] Bad channel key from rrr.rr.rr.r
11:26:03 silc_server_purge_expired_clients:1268: Expire timeout
11:26:59 silc_server_accept_new_connection:2734: Accepting new connection
11:26:59 silc_server_accept_new_connection:2766: Created packet stream 0x494a2a00
11:26:59 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85eb00
11:26:59 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 3->4
11:26:59 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 4->5
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:26:59 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:27:01 silc_server_packet_eos:197: End of stream received, sock 0x494a2a00
11:27:01 silc_server_free_sock_user_data:3171: Start, sock 0x494a2a00
11:27:01 silc_server_free_sock_user_data:3188: Abort active protocol
11:27:01 silc_server_free_sock_user_data:3408: Freeing unknown connection data 0x4d85eb00
[Logging] [Info] Closing connection ssss.ss.ss.ss:12722 []
11:27:30 silc_server_get_stats:5295: Retrieving stats from router
11:27:30 silc_server_packet_send:47: Sending COMMAND packet
11:27:30 silc_server_packet_parse_type:307: Received COMMAND REPLY packet [flags 0]
11:27:30 silc_server_command_reply:1866: Start
11:27:30 silc_server_command_reply_process:72: Start
11:27:30 silc_server_command_reply_stats:1220: Start
11:27:37 silc_server_accept_new_connection:2734: Accepting new connection
11:27:37 silc_server_accept_new_connection:2766: Created packet stream 0x4d85e700
11:27:37 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85e900
11:27:37 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 5->6
11:27:37 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 6->7
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:27:37 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:27:42 silc_server_packet_eos:197: End of stream received, sock 0x4d85e700
11:27:42 silc_server_free_sock_user_data:3171: Start, sock 0x4d85e700
11:27:42 silc_server_free_sock_user_data:3188: Abort active protocol
11:27:42 silc_server_free_sock_user_data:3408: Freeing unknown connection data 0x4d85e900
[Logging] [Info] Closing connection ssss.ss.ss.ss:36566 []
11:27:46 silc_server_accept_new_connection:2734: Accepting new connection
11:27:46 silc_server_accept_new_connection:2766: Created packet stream 0x4d85f300
11:27:46 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85e300
11:27:46 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:27:46 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:27:46 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:27:47 silc_server_accept_completed:2671: Setting keys into use
11:27:47 silc_server_accept_completed:2693: Starting connection authentication
11:27:47 silc_server_accept_get_auth:2148: Remote connection type 2
11:27:47 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:27:47 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:27:47 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:27:47 silc_idlist_add_server:83: Adding new server entry
11:27:47 silc_server_accept_auth_compl:2570: my_servers 2
11:27:47 silc_server_accept_auth_compl:2617: New connection 0x4b39fb00 authenticated
11:27:47 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:27:47 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:27:48 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:27:48 silc_server_new_server:2335: Creating new server
11:27:48 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:27:48 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:27:48 silc_server_new_server:2486: New server id(sss.ss.ss.ss,49666,[00 ff])
11:27:48 silc_server_send_new_id:1407: Sending new ID
11:27:48 silc_server_packet_send:47: Sending NEW ID packet
11:27:48 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:27:48 silc_server_new_id_real:2587: Processing new ID
11:27:48 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:27:48 silc_idlist_find_server_by_id:137: Found
11:27:48 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:27:48 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:27:48 silc_idlist_find_server_by_id:137: Found
11:27:48 silc_server_new_id_real:2739: Ignoring server that we already have
11:27:57 silc_server_packet_parse_type:307: Received DISCONNECT packet [flags 0]
[Logging] [Info] Disconnected by sss.ss.ss.ss (ssss.ss.ss.ss):  (0) Server is shutting down
11:27:57 silc_server_free_sock_user_data:3171: Start, sock 0x4d85f300
11:27:57 silc_server_free_sock_user_data:3209: Freeing server 0x4d85ea00 data
11:27:57 silc_server_send_opers:1625: Sending NOTIFY packet to operators
11:27:57 silc_server_remove_servers_by_server:782: Removing servers by ssss.ss.ss.ss
11:27:57 silc_server_remove_clients_by_server:150: Removing clients by ssss.ss.ss.ss
11:27:57 silc_server_remove_clients_by_server:324: Sending SERVER_SIGNOFF for sss.ss.ss.ss,49666,[00 ff] with 0 clients
11:27:57 silc_server_packet_send:47: Sending NOTIFY packet
11:27:57 silc_server_connection_free:1300: Free connection 0x4b39fb00
11:27:57 silc_server_free_sock_user_data:3370: my_servers 1
11:27:57 silc_idlist_del_server:265: Deleting server ssss.ss.ss.ss id sss.ss.ss.ss,49666,[00 ff]
[Logging] [Info] Closing connection ssss.ss.ss.ss:12905 []
11:27:57 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:27:57 silc_server_notify_process:1190: SERVER SIGNOFF notify
11:27:57 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:27:57 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:03 silc_server_purge_expired_clients:1268: Expire timeout
11:28:24 silc_server_accept_new_connection:2734: Accepting new connection
11:28:24 silc_server_accept_new_connection:2766: Created packet stream 0x494a2a00
11:28:24 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85f100
11:28:24 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:28:24 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:28:24 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:28:25 silc_server_accept_completed:2671: Setting keys into use
11:28:25 silc_server_accept_completed:2693: Starting connection authentication
11:28:25 silc_server_accept_get_auth:2148: Remote connection type 2
11:28:25 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:28:25 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:28:25 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:28:25 silc_idlist_add_server:83: Adding new server entry
11:28:25 silc_server_accept_auth_compl:2570: my_servers 2
11:28:25 silc_server_accept_auth_compl:2617: New connection 0x4b39fb00 authenticated
11:28:25 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:28:25 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:28:25 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:28:25 silc_server_new_server:2335: Creating new server
11:28:25 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:25 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:25 silc_server_new_server:2486: New server id(sss.ss.ss.ss,49666,[00 ff])
11:28:25 silc_server_send_new_id:1407: Sending new ID
11:28:25 silc_server_packet_send:47: Sending NEW ID packet
11:28:25 silc_server_packet_parse_type:307: Received NEW ID packet [flags 0]
11:28:25 silc_server_new_id_real:2587: Processing new ID
11:28:25 silc_idlist_find_server_by_id:123: Server ID (rrr.rr.rr.r,49666,[00 ff])
11:28:25 silc_idlist_find_server_by_id:137: Found
11:28:25 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:25 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:25 silc_idlist_find_server_by_id:137: Found
11:28:25 silc_server_new_id_real:2739: Ignoring server that we already have
11:28:38 silc_server_packet_parse_type:307: Received NOTIFY packet [flags 0]
11:28:38 silc_server_notify_process:1190: SERVER SIGNOFF notify
11:28:38 silc_server_notify_process:1204: Ignoring my own ID for SERVER_SIGNOFF
11:28:39 silc_server_accept_new_connection:2734: Accepting new connection
11:28:39 silc_server_accept_new_connection:2766: Created packet stream 0x4d85ef00
11:28:39 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85e700
11:28:39 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:28:39 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:28:39 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:28:40 silc_server_accept_completed:2671: Setting keys into use
11:28:40 silc_server_accept_completed:2693: Starting connection authentication
11:28:40 silc_server_accept_get_auth:2148: Remote connection type 2
11:28:40 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:28:40 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:28:40 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:28:40 silc_idlist_add_server:83: Adding new server entry
11:28:40 silc_server_accept_auth_compl:2570: my_servers 3
11:28:40 silc_server_accept_auth_compl:2617: New connection 0x4da6e880 authenticated
11:28:40 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:28:40 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:28:40 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:28:40 silc_server_new_server:2335: Creating new server
11:28:40 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:40 silc_idlist_find_server_by_id:137: Found
[Logging] [Error] Too many registrations from sss.ss.ss.ss (ssss.ss.ss.ss)
11:28:40 silc_server_disconnect_remote:3064: Disconnecting remote host, sock 0x4d85ef00
[Logging] [Info] Closing connection ssss.ss.ss.ss:36162 [Server]
11:28:40 silc_server_connection_free:1300: Free connection 0x4da6e880
11:28:40 silc_server_free_sock_user_data:3171: Start, sock 0x4d85ef00
11:28:40 silc_server_free_sock_user_data:3209: Freeing server 0x4da70800 data
11:28:40 silc_server_remove_servers_by_server:782: Removing servers by server
11:28:40 silc_server_free_sock_user_data:3370: my_servers 2
11:28:40 silc_idlist_del_server:258: Unknown server, did not delete
11:28:40 silc_idlist_del_server:258: Unknown server, did not delete
11:28:41 silc_server_accept_new_connection:2734: Accepting new connection
11:28:41 silc_server_accept_new_connection:2766: Created packet stream 0x4da70c00
11:28:41 silc_server_accept_new_connection:2827: Created unknown connection 0x4da70900
11:28:41 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:28:41 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:28:41 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:28:42 silc_server_accept_completed:2671: Setting keys into use
11:28:42 silc_server_accept_completed:2693: Starting connection authentication
11:28:42 silc_server_accept_get_auth:2148: Remote connection type 2
11:28:42 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:28:42 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:28:42 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:28:42 silc_idlist_add_server:83: Adding new server entry
11:28:42 silc_server_accept_auth_compl:2570: my_servers 3
11:28:42 silc_server_accept_auth_compl:2617: New connection 0x4da6e600 authenticated
11:28:42 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:28:42 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:28:42 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:28:42 silc_server_new_server:2335: Creating new server
11:28:42 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:42 silc_idlist_find_server_by_id:137: Found
[Logging] [Error] Too many registrations from sss.ss.ss.ss (ssss.ss.ss.ss)
11:28:42 silc_server_disconnect_remote:3064: Disconnecting remote host, sock 0x4da70c00
[Logging] [Info] Closing connection ssss.ss.ss.ss:19055 [Server]
11:28:42 silc_server_connection_free:1300: Free connection 0x4da6e600
11:28:42 silc_server_free_sock_user_data:3171: Start, sock 0x4da70c00
11:28:42 silc_server_free_sock_user_data:3209: Freeing server 0x4d85e700 data
11:28:42 silc_server_remove_servers_by_server:782: Removing servers by server
11:28:42 silc_server_free_sock_user_data:3370: my_servers 2
11:28:42 silc_idlist_del_server:258: Unknown server, did not delete
11:28:42 silc_idlist_del_server:258: Unknown server, did not delete
11:28:44 silc_server_accept_new_connection:2734: Accepting new connection
11:28:44 silc_server_accept_new_connection:2766: Created packet stream 0x4d85ec00
11:28:44 silc_server_accept_new_connection:2827: Created unknown connection 0x4d85ef00
11:28:44 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:28:44 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:28:44 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:28:45 silc_server_accept_completed:2671: Setting keys into use
11:28:45 silc_server_accept_completed:2693: Starting connection authentication
11:28:45 silc_server_accept_get_auth:2148: Remote connection type 2
11:28:45 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:28:45 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:28:45 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:28:45 silc_idlist_add_server:83: Adding new server entry
11:28:45 silc_server_accept_auth_compl:2570: my_servers 3
11:28:45 silc_server_accept_auth_compl:2617: New connection 0x4da6e580 authenticated
11:28:45 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:28:45 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:28:45 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:28:45 silc_server_new_server:2335: Creating new server
11:28:45 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:45 silc_idlist_find_server_by_id:137: Found
[Logging] [Error] Too many registrations from sss.ss.ss.ss (ssss.ss.ss.ss)
11:28:45 silc_server_disconnect_remote:3064: Disconnecting remote host, sock 0x4d85ec00
[Logging] [Info] Closing connection ssss.ss.ss.ss:9524 [Server]
11:28:45 silc_server_connection_free:1300: Free connection 0x4da6e580
11:28:45 silc_server_free_sock_user_data:3171: Start, sock 0x4d85ec00
11:28:45 silc_server_free_sock_user_data:3209: Freeing server 0x4da71200 data
11:28:45 silc_server_remove_servers_by_server:782: Removing servers by server
11:28:45 silc_server_free_sock_user_data:3370: my_servers 2
11:28:45 silc_idlist_del_server:258: Unknown server, did not delete
11:28:45 silc_idlist_del_server:258: Unknown server, did not delete
11:28:47 silc_server_accept_new_connection:2734: Accepting new connection
11:28:47 silc_server_accept_new_connection:2766: Created packet stream 0x4da71500
11:28:47 silc_server_accept_new_connection:2827: Created unknown connection 0x4da70900
11:28:47 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 7->8
11:28:47 silc_server_config_ref:1580: Referencing config [0x45901e00] refcnt 8->9
[Logging] [Info] Incoming connection ssss.ss.ss.ss (sss.ss.ss.ss)
11:28:47 silc_server_accept_new_connection:2847: Starting key exchange protocol
11:28:48 silc_server_accept_completed:2671: Setting keys into use
11:28:48 silc_server_accept_completed:2693: Starting connection authentication
11:28:48 silc_server_accept_get_auth:2148: Remote connection type 2
11:28:48 silc_server_accept_auth_compl:2265: Checking whether connection is allowed
11:28:48 silc_server_connection_allowed:1175: Checking whether connection is allowed
11:28:48 silc_server_accept_auth_compl:2509: Remote host is server
[Logging] [Info] Connection ssss.ss.ss.ss (sss.ss.ss.ss) is server
11:28:48 silc_idlist_add_server:83: Adding new server entry
11:28:48 silc_server_accept_auth_compl:2570: my_servers 3
11:28:48 silc_server_accept_auth_compl:2617: New connection 0x4da6e380 authenticated
11:28:48 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 9->8
11:28:48 silc_server_config_destroy:1601: Unreferencing config [0x45901e00] refcnt 8->7
11:28:48 silc_server_packet_parse_type:307: Received NEW SERVER packet [flags 0]
11:28:48 silc_server_new_server:2335: Creating new server
11:28:48 silc_idlist_find_server_by_id:123: Server ID (sss.ss.ss.ss,49666,[00 ff])
11:28:48 silc_idlist_find_server_by_id:137: Found
[Logging] [Error] Too many registrations from sss.ss.ss.ss (ssss.ss.ss.ss)
11:28:48 silc_server_disconnect_remote:3064: Disconnecting remote host, sock 0x4da71500
[Logging] [Info] Closing connection ssss.ss.ss.ss:15284 [Server]
11:28:48 silc_server_connection_free:1300: Free connection 0x4da6e380
11:28:48 silc_server_free_sock_user_data:3171: Start, sock 0x4da71500
11:28:48 silc_server_free_sock_user_data:3209: Freeing server 0x4da71700 data
11:28:48 silc_server_remove_servers_by_server:782: Removing servers by server
11:28:48 silc_server_free_sock_user_data:3370: my_servers 2
11:28:48 silc_idlist_del_server:258: Unknown server, did not delete
11:28:48 silc_idlist_del_server:258: Unknown server, did not delete

_______________________________________________________________________
Info:    https://lists.silcnet.org/mailman/listinfo/silc-announce
Archive: https://lists.silcnet.org/pipermail/silc-announce
FAQ:     http://silcnet.org/support/faq/