опять RADIUS

Технические вопросы по UTM 5.0
Ответить
Martin
Сообщения: 99
Зарегистрирован: Пт янв 21, 2005 09:53

опять RADIUS

Сообщение Martin »

radius.log

Код: Выделить всё

?Debug : Aug 19 08:40:05 RADIUS URFA[upload]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:40:35 RADIUS URFA[plugin]: Failed to open session: Permission denied
?Debug : Aug 19 08:40:35 RADIUS URFA[plugin]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:40:35 RADIUS URFA[upload]: Failed to open session: Permission denied
?Debug : Aug 19 08:40:35 RADIUS URFA[upload]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:41:05 RADIUS URFA[plugin]: Failed to open session: Permission denied
?Debug : Aug 19 08:41:05 RADIUS URFA[plugin]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:41:05 RADIUS URFA[upload]: Failed to open session: Permission denied
?Debug : Aug 19 08:41:05 RADIUS URFA[upload]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:41:35 RADIUS URFA[plugin]: Failed to open session: Permission denied
?Debug : Aug 19 08:41:35 RADIUS URFA[plugin]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:41:35 RADIUS URFA[upload]: Failed to open session: Permission denied
?Debug : Aug 19 08:41:35 RADIUS URFA[upload]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:42:05 RADIUS URFA[plugin]: Failed to open session: Permission denied
?Debug : Aug 19 08:42:05 RADIUS URFA[plugin]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:42:05 RADIUS URFA[upload]: Failed to open session: Permission denied
?Debug : Aug 19 08:42:05 RADIUS URFA[upload]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:42:35 RADIUS URFA[plugin]: Failed to open session: Permission denied
?Debug : Aug 19 08:42:35 RADIUS URFA[plugin]: [restart]: Reconnect loop. Sleeping for 30 sec...
 ERROR : Aug 19 08:42:35 RADIUS URFA[upload]: Failed to open session: Permission denied

main.log

Код: Выделить всё

 ERROR &#58; Aug 19 08&#58;40&#58;05 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; SSL connection failed...
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;32787
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;32787
 Notice&#58; Aug 19 08&#58;40&#58;05 RPCConn&#58; Service <radius@127.0.0.1> is connecting
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; Access granted to &#91;SSL&#93;<radius@127.0.0.1> &#40;UID&#58; -2&#41;
 ERROR &#58; Aug 19 08&#58;40&#58;05 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; SSL connection failed...
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;32788
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;32788
 Notice&#58; Aug 19 08&#58;40&#58;05 RPCConn&#58; Service <radius@127.0.0.1> is connecting
 Info  &#58; Aug 19 08&#58;40&#58;05 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; Access granted to &#91;SSL&#93;<radius@127.0.0.1> &#40;UID&#58; -2&#41;
 Info  &#58; Aug 19 08&#58;40&#58;23 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;32789
 Info  &#58; Aug 19 08&#58;40&#58;23 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;32789
 Info  &#58; Aug 19 08&#58;40&#58;23 RPCConn&#91;SSL&#93;<init@127.0.0.1>&#58; Access granted to &#91;SSL&#93;<init@127.0.0.1> &#40;UID&#58; -1&#41;
 Info  &#58; Aug 19 08&#58;40&#58;23 RPCConn&#91;SSL&#93;<init@127.0.0.1>&#58; Connection terminated by peer
 ERROR &#58; Aug 19 08&#58;40&#58;35 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; SSL connection failed...
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;32790
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;32790
 Notice&#58; Aug 19 08&#58;40&#58;35 RPCConn&#58; Service <radius@127.0.0.1> is connecting
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; Access granted to &#91;SSL&#93;<radius@127.0.0.1> &#40;UID&#58; -2&#41;
 ERROR &#58; Aug 19 08&#58;40&#58;35 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; SSL connection failed...
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;32791
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;32791
 Notice&#58; Aug 19 08&#58;40&#58;35 RPCConn&#58; Service <radius@127.0.0.1> is connecting
 Info  &#58; Aug 19 08&#58;40&#58;35 RPCConn&#91;SSL&#93;<radius@127.0.0.1>&#58; Access granted to &#91;SSL&#93;<radius@127.0.0.1> &#40;UID&#58; -2&#41;
останавливаем радиус и запускаем заново - все начинает работать.
как лечить?


UTM-5.1.10-013

spec
Сообщения: 371
Зарегистрирован: Сб апр 16, 2005 14:03

Сообщение spec »

поставить последний билд

Blackmore
Сообщения: 365
Зарегистрирован: Вс фев 06, 2005 09:24
Откуда: подмосковье

Сообщение Blackmore »

страшновато радиус запускать :) - а что проблемы радиуса устранили все в последнем билде ?

Martin
Сообщения: 99
Зарегистрирован: Пт янв 21, 2005 09:53

Сообщение Martin »

spec писал(а):поставить последний билд
поставил.... мда...
сначало все нормально, потом ошибка 718 (уделеный комп не ответил вовремя на запрос).
перезапускаем радиус и все ок. раньше хоть радиус в лог писал что-то. а тут у него чисто - хотя видно что он работает, т.к. он прогружал себе балансы.

Код: Выделить всё

?Debug &#58; Aug 24 08&#58;52&#58;14 RADIUS URFA&#91;plugin&#93;&#58; Account <3> with balance <-120.933>
?Debug &#58; Aug 24 08&#58;52&#58;14 RADIUS URFA&#91;plugin&#93;&#58; Account <59> with balance <-0.000>
?Debug &#58; Aug 24 08&#58;52&#58;14 RADIUS URFA&#91;plugin&#93;&#58; Account <59> with balance <-0.000>
?Debug &#58; Aug 24 08&#58;52&#58;14 RADIUS URFA&#91;plugin&#93;&#58; Account <59> with balance <-0.000>
?Debug &#58; Aug 24 08&#58;52&#58;14 RADIUS URFA&#91;plugin&#93;&#58; Account <48> with balance <41.853>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <2> with balance <-173.978>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <48> with balance <41.853>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <48> with balance <41.853>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <49> with balance <75.219>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <49> with balance <75.219>
?Debug &#58; Aug 24 09&#58;07&#58;23 RADIUS URFA&#91;plugin&#93;&#58; Account <3> with balance <-120.933> 
единственное что нашел в debug.log

Код: Выделить всё

Info  &#58; Aug 24 09&#58;08&#58;33 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;34774
 Info  &#58; Aug 24 09&#58;08&#58;33 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;34774
 Info  &#58; Aug 24 09&#58;08&#58;33 RPCConn<spider@192.168.73.77>&#58; Access granted to <spider@192.168.73.77> &#40;UID&#58; 4&#41;
 Info  &#58; Aug 24 09&#58;08&#58;33 RPCConn<spider@192.168.73.77>&#58; Connection terminated by peer
?Debug &#58; Aug 24 09&#58;08&#58;33 RPCConn<spider@192.168.73.77>&#58; Session stored for UID 4 and IP 4d49a8c0
?Debug &#58; Aug 24 09&#58;08&#58;33 RPCConn<spider@192.168.73.77>&#58; Session closed...
 Info  &#58; Aug 24 09&#58;08&#58;34 RPCServer@0.0.0.0&#58; Client connecting&#58; 127.0.0.1&#58;34775
 Info  &#58; Aug 24 09&#58;08&#58;34 RPCConn&#58; Connection from&#58; 127.0.0.1&#58;34775
 Notice&#58; Aug 24 09&#58;08&#58;34 RPCConn&#58; Service <init@127.0.0.1> is connecting
?Debug &#58; Aug 24 09&#58;08&#58;34 RPCConn&#58; Session restored for <spider@192.168.73.77>
 Info  &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Access granted to <spider@192.168.73.77> &#40;UID&#58; 4&#41;
?Debug &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Call&#58; 0xffffbffa
?Debug &#58; Aug 24 09&#58;08&#58;34 DBCtx&#58; SQL SELECT query&#58; SELECT 		login, 		password, 		basic_account, 		is_blocked, 		create_date, 		last_change_date, 		who_create, 		who_change, 		is_juridical, 		full_name, 		juridical_address, 		actual_address, 		work_telephone, 		home_telephone, 		mobile_telephone, 		web_page, 		icq_number, 		tax_number, 		kpp_number, 		bank_id, 		bank_account, 		comments, 		discount_period_id, 		email, 		house_id, 		flat_number, 		entrance, 		floor, 		passport, 		personal_manager, 		connect_date, 		is_send_invoice, 		advance_payment 		FROM users WHERE id='4' AND is_deleted=0
?Debug &#58; Aug 24 09&#58;08&#58;34 DBCtx&#58; SQL SELECT query&#58; SELECT group_id FROM users_groups_link WHERE user_id='4'
?Debug &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Call finished...
 Info  &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Connection terminated by peer
?Debug &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Session stored for UID 4 and IP 4d49a8c0
?Debug &#58; Aug 24 09&#58;08&#58;34 RPCConn<spider@192.168.73.77>&#58; Session closed... 


aospan
NetUP Team
Сообщения: 1639
Зарегистрирован: Чт янв 13, 2005 20:30

Сообщение aospan »

Martin писал(а):
spec писал(а):поставить последний билд
поставил.... мда...
сначало все нормально, потом ошибка 718 (уделеный комп не ответил вовремя на запрос).
перезапускаем радиус и все ок. раньше хоть радиус в лог писал что-то. а тут у него чисто - хотя видно что он работает, т.к. он прогружал себе балансы.
Очень похоже, что на радиус не приходили пакеты. Попробуйте посмотреть при помощи утилиты tcpdump идут ли на радиус пакеты по портам 1812 и 1813.

Ответить