BiTel

Форум BiTel
bgbilling.ru     docs.bitel.ru     wiki.bitel.ru     dbinfo.bitel.ru     bgcrm.ru     billing.bitel.ru     bitel.ru    
Текущее время: 28 апр 2024, 11:00

Часовой пояс: UTC + 5 часов [ Летнее время ]




Начать новую тему Ответить на тему  [ Сообщений: 8 ] 
Автор Сообщение
 Заголовок сообщения: Проблемы с сессиями
СообщениеДобавлено: 13 сен 2012, 11:27 
Не в сети

Зарегистрирован: 28 июл 2011, 10:33
Сообщения: 37
Карма: 0
Здравствуйте!
Существует проблема на CentOS 6.3, постоянно отлетают сессии, причём всё это происходит в хаотичном порядке и в разных местах магистрали. Есть подозрения на то, что RADIUS перестаёт получать update-пакеты. RADIUS настроен как в мануле. На сервере стоит radiusclient-ng.
Подскажите в какую сторону копать т.к. после падения соединения начинают появлятся зависшие сессии.
Если нужна дополнительная информация, напишите, все предоставлю.
Спасибо.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 13 сен 2012, 12:25 
Не в сети

Зарегистрирован: 22 дек 2008, 13:02
Сообщения: 270
Откуда: Москва
Карма: 27
Ошибки в connection.log есть какие? Если нет, то что вобще там есть.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 14 сен 2012, 07:33 
Не в сети

Зарегистрирован: 19 авг 2012, 18:32
Сообщения: 16
Карма: 0
Да и вообще, показывайте через тэг code вывод из error.log и остальных файлов.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 14 сен 2012, 10:51 
Не в сети

Зарегистрирован: 28 июл 2011, 10:33
Сообщения: 37
Карма: 0
connection.log
Код:
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] updateBytes
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] before update bytesIn=0; bytesOut=0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpNASConnection after update bytesIn=100396; bytesOut=62932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Set traffic by type => 1; value => 100396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Set traffic by type => 2; value => 62932
09-14/10:47:04  INFO [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpNASConnection update connection..
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime recalculating useLimits => true; hasLimitC
hecker => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Calculate traffics..
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic SID => 9; value [ calculated ] => 100396 [ 0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic delta => 100396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime calculateService time => 10:00:00; service
ID => 9; needAmount => 100396; useLimits => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Contract: test1; limit: 0.00; mode: DEBET
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] balance => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] tariff => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] maxAmount => 100396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Use limiting takedService => 100396; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Using tariff 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] after Limiting serviceAmount => 100396; summa => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedService => 100396; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSession updateSessionDetail() serviceID => 9; amount => 10
0396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] inserting new record insession_detail_1_201209
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] calculated [ cost ] => 100396 [ 0.0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] status => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic SID => 10; value [ calculated ] => 62932 [ 0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic delta => 62932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime calculateService time => 10:00:00; service
ID => 10; needAmount => 62932; useLimits => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Contract: test1; limit: 0.00; mode: DEBET
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] balance => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] tariff => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] maxAmount => 62932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Use limiting takedService => 62932; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Using tariff 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] after Limiting serviceAmount => 62932; summa => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedService => 62932; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSession updateSessionDetail() serviceID => 10; amount => 6
2932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] inserting new record insession_detail_1_201209
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] calculated [ cost ] => 62932 [ 0.0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] status => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic SID => 7; value [ calculated ] => 100396 [ 0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic delta => 100396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime calculateService time => 10:00:00; service
ID => 7; needAmount => 100396; useLimits => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Contract: test1; limit: 0.00; mode: DEBET
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] balance => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] tariff => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] maxAmount => 100396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Use limiting takedService => 100396; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Using tariff 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] after Limiting serviceAmount => 100396; summa => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedService => 100396; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSession updateSessionDetail() serviceID => 7; amount => 10
0396
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] inserting new record insession_detail_1_201209
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] calculated [ cost ] => 100396 [ 0.0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] status => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic SID => 8; value [ calculated ] => 62932 [ 0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] traffic delta => 62932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime calculateService time => 10:00:00; service
ID => 8; needAmount => 62932; useLimits => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Contract: test1; limit: 0.00; mode: DEBET
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] balance => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] tariff => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] maxAmount => 62932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Use limiting takedService => 62932; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Using tariff 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] after Limiting serviceAmount => 62932; summa => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedService => 62932; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSession updateSessionDetail() serviceID => 8; amount => 62
932
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] inserting new record insession_detail_1_201209
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] calculated [ cost ] => 62932 [ 0.0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] status => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] calculatedStopTime => 10:46:04; needStopTime => 10:47:04
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] delta => 60
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime calculateService time => 10:00:00; service
ID => 12; needAmount => 60; useLimits => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Contract: test1; limit: 0.00; mode: DEBET
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] balance => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] tariff => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] maxAmount => 60
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Use limiting takedService => 60; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Using tariff 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] after Limiting serviceAmount => 60; summa => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedService => 60; takedMoney => 0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSession updateSessionDetail() serviceID => 12; amount => 6
0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] inserting new record insession_detail_1_201209
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] takedTime [ cost ] => 60 [ 0.0 ]
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] d_sec => 0; calculatedStopTime => 10:47:04
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime recalculate result => true
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Updating contract_balance add cost=0.0
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] Skip zero update balance
09-14/10:47:04 DEBUG [rdsLstnr-p-5-t-51] connections - [ test1; test1; 61163 ] DialUpSessionRealtime updateSession  addCost => 0.0; bytesIn =>
100396; bytesOut => 62932
09-14/10:47:15 DEBUG [Thread-11] connections - [ test1; test1; 61163 ] Checking zombi delta => 10; status => working; dropSleepTimeOut => 3600


вот error.log
Код:
script 09-13/14:02:13 ERROR [main] ScriptEventListener - Ljavax/servlet/http/HttpServletRequest;
java.lang.NoClassDefFoundError: Ljavax/servlet/http/HttpServletRequest;
        at java.lang.Class.getDeclaredFields0(Native Method)
        at java.lang.Class.privateGetDeclaredFields(Class.java:2291)
        at java.lang.Class.getDeclaredFields(Class.java:1743)
        at ru.bitel.common.SerialUtils.generateSerialVersionUID(SerialUtils.java:70)
        at ru.bitel.bgbilling.kernel.event.events.ActionBeforeEvent.<clinit>(ActionBeforeEvent.java:29)
        at java.lang.Class.forName0(Native Method)
        at java.lang.Class.forName(Class.java:169)
        at ru.bitel.bgbilling.kernel.script.server.ScriptEventListener.parse(ScriptEventListener.java:531)
        at ru.bitel.bgbilling.kernel.script.server.ScriptEventListener.getEventTypeKeys(ScriptEventListener.java:504)
        at ru.bitel.bgbilling.kernel.script.server.ScriptEventListener.relinkFunctions(ScriptEventListener.java:742)
        at ru.bitel.bgbilling.kernel.script.server.ScriptEventListener.start(ScriptEventListener.java:721)
        at ru.bitel.bgbilling.kernel.event.processors.ScriptEventProcessor.start(ScriptEventProcessor.java:34)
        at bitel.billing.server.radius.Radius.<init>(Radius.java:60)
        at bitel.billing.server.radius.Radius.main(Radius.java:156)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:597)
        at ru.bitel.common.bootstrap.Boot.boot(Boot.java:129)
        at ru.bitel.common.bootstrap.Boot.main(Boot.java:178)
Caused by: java.lang.ClassNotFoundException: javax.servlet.http.HttpServletRequest
        at java.net.URLClassLoader$1.run(URLClassLoader.java:202)
        at java.security.AccessController.doPrivileged(Native Method)
        at java.net.URLClassLoader.findClass(URLClassLoader.java:190)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:306)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:247)
        ... 20 more
radius 09-13/16:31:10 ERROR [rdsLstnr-p-4-t-53] DialUpNasConnection - Stop without start!
radius 09-13/16:31:20 ERROR [rdsLstnr-p-4-t-60] DialUpNasConnection - Stop without start!
radius 09-13/16:31:20 ERROR [rdsLstnr-p-4-t-62] DialUpNasConnection - Stop without start!
radius 09-13/16:31:36 ERROR [rdsLstnr-p-4-t-75] DialUpNasConnection - Stop without start!
radius 09-13/16:37:13 ERROR [Thread-22] processor - IP address marked as used incorrect: 172.16.126.196, removing..
radius 09-13/21:24:00 ERROR [rdsLstnr-p-4-t-29] DialUpNasConnection - Stop without start!
radius 09-13/22:55:20 ERROR [rdsLstnr-p-4-t-13] DialUpNasConnection - Stop without start!
processor 09-13/22:59:13 ERROR [Thread-16] DialUpNasConnection - Stop without start!
radius 09-13/23:07:14 ERROR [Thread-22] processor - IP address marked as used incorrect: 172.16.50.180, removing..


Также появились сомнения по поводу PPTPD+PPPD


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 14 сен 2012, 16:30 
Не в сети

Зарегистрирован: 22 дек 2008, 13:02
Сообщения: 270
Откуда: Москва
Карма: 27
Код:
 DialUpNasConnection - Stop without start!

Вот эта ошибка она намекает нам что возможна ситуация когда на NAS есть рабочие сессии которых нету в билинговом радиусе. Посмотрите что по такой ошибке в акаунтинге возникает.
Дикая догадка №1: Возможно что NAS не отправляет радиусу информацию о закрытых по какой-то причине сессий.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 14 сен 2012, 20:55 
Не в сети

Зарегистрирован: 19 авг 2012, 18:32
Сообщения: 16
Карма: 0
1. Проверьте наличия места на диске для БД
2. Проверьте настройки таймаута для радиуса
3. Посмотрите сколько у вас отъедается памяти через htop, может её тупо не хватает и появляются хаотичные дропы.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 18 сен 2012, 22:46 
Не в сети
Клиент

Зарегистрирован: 12 фев 2008, 18:10
Сообщения: 3951
Карма: 249
aardvark писал(а):
Код:
 DialUpNasConnection - Stop without start!

Вот эта ошибка она намекает нам что возможна ситуация когда на NAS есть рабочие сессии которых нету в билинговом радиусе.

Кажется такая ошибка бывает с Reject-to-Accept сессиями, т.к. RADIUS их не мониторит, то stop с NAS-а у него вызывает приступ недоумения и он пишет ошибку.


Вернуться к началу
 Профиль  
 
 Заголовок сообщения: Re: Проблемы с сессиями
СообщениеДобавлено: 20 сен 2012, 16:46 
Не в сети

Зарегистрирован: 28 июл 2011, 10:33
Сообщения: 37
Карма: 0
[S] писал(а):
1. Проверьте наличия места на диске для БД
2. Проверьте настройки таймаута для радиуса
3. Посмотрите сколько у вас отъедается памяти через htop, может её тупо не хватает и появляются хаотичные дропы.

1. Места на диске достаточно 8 Тб.
2. Таймаут в биллинге 3600.
3. Памяти выделено 1024 Мб. Должно хватать.


Вернуться к началу
 Профиль  
 
Показать сообщения за:  Поле сортировки  
Начать новую тему Ответить на тему  [ Сообщений: 8 ] 

Часовой пояс: UTC + 5 часов [ Летнее время ]


Кто сейчас на конференции

Сейчас этот форум просматривают: нет зарегистрированных пользователей и гости: 1


Вы не можете начинать темы
Вы не можете отвечать на сообщения
Вы не можете редактировать свои сообщения
Вы не можете удалять свои сообщения
Вы не можете добавлять вложения

Найти:
Перейти:  
POWERED_BY
Русская поддержка phpBB
[ Time : 0.713s | 34 Queries | GZIP : On ]