BiTel

Добрый день!
Чет непонятно чтото с сервисом твориться.
Обновился до последнего релиза 6.0 . До обновления все работало нормально. После обновления что то неладное со статусом сервиса в договоре, причем у малой части клиентов.
Например подключение по пптп. Баланс положительный, лимит 0. Статус сервиса открыт, а вот состояния бывают разные, например Отключен(недостаток средств) или удален.
Закономерности никакой не нашел. Причем access разрешает подключиться и аккаунтинг считает трафик.

лог access
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetNas - Search by username=6dsd2sd47awef9av1!@7
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - [username=6dsd2sd47awef9av1!@7] Authenticated as inetServId:872
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetApplication - TariffOptionMap: {}
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetApplication - inetServ[id=872] balance ok: -85.05 [-300.00]
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetApplication - OptionSet: [35, 6, 36, 37, 9]
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Not found free IP-address in serv
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Set ip from pool
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Write new waiting connection to DB
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - New connection id=560075
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Return code=0
04-14/18:33:42 INFO [rdsLstnr-p-9-t-11] InetRadiusListenerWorker - RESPONSE:
Packet type: Access-Accept

Лог accounting
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] InetNas - Search by username=6dsd2sd47awef9av1!@7
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] InetRadiusProcessor - Creating NasConnection from radius accounting packet
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] InetRadiusProcessor - Connection exist in DB
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] InetNas - agentRemoteId=null
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] InetAccountingPeriodList - Create:
AccountingPeriod: 2936: 01.04.2015 00:00:00.0 - 30.04.2015 23:59:59.999
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] Accounting - Update connection in DB
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] Accounting - Write new session to DB
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] Accounting - New session's id=543722
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] Accounting - Created new AccountingSession.
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] connection - 560075:543722 Register ip: 10.24.49.236
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] IpResourceRuntimeManager - Subscribing 10.24.49.236 to contractId=3123
mq 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] EventProcessor - Publish: Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEvent] moduleId: 15; pluginId: no; cid: 3123; scid: -1; userId: 0; type: 1; deviceId: 4; connectionId: 560075; timestamp: 1429011225530
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] Accounting - InetConnection [id=560075-0, iface=4:35104087, sessId=0217A559, start=14.04.2015 18:33:45, uname=6dsd2sd47awef9av1!@7, addr=10.24.49.236]
radius 04-14/18:33:45 DEBUG [rdsLstnr-p-10-t-12] ProcessorRequest - Sending to /10.24.47.6:1646
radius 04-14/18:33:45 INFO [rdsLstnr-p-10-t-12] RadiusListenerWorker - RESPONSE:
Packet type: Accounting-Response

все версии из окна about

_________________
I'm clever. I've got a computer.

Информация о версии:

Клиент: вер. 6.0 сборка 1375 от 30.03.2015 19:17:55
os: Windows 7; java: Java HotSpot(TM) Client VM, v.1.7.0_67
Сервер: вер. 6.0 сборка 1845 от 09.04.2015 12:50:15
os: Linux; java: OpenJDK Client VM, v.1.6.0_27
bill вер. 6.0 сборка 350 от 24.02.2015 20:15:22
card вер. 6.0 сборка 230 от 09.02.2015 18:40:44
dialup вер. 6.0 сборка 408 от 13.02.2015 20:00:06
inet вер. 6.0 сборка 1495 от 07.04.2015 18:17:00
ipn вер. 6.0 сборка 278 от 09.02.2015 18:41:13
npay вер. 6.0 сборка 231 от 13.02.2015 20:00:05
pay вер. сборка от
phone вер. 6.0 сборка 304 от 18.02.2015 15:21:49
reports вер. 6.0 сборка 224 от 30.03.2015 19:04:18
rscm вер. 6.0 сборка 196 от 07.04.2015 18:17:02
ru.bitel.bgbilling.plugins.dispatch вер. 6.0 сборка 160 от 09.02.2015 18:41:29
trayinfo вер. 6.0 сборка 177 от 09.02.2015 18:41:24
voiceip вер. 6.0 сборка 234 от 09.02.2015 18:41:23

Говорите что баланс положительный, лимит 0, а по логу balance ok: -85.05 [-300.00], зависимые балансы у договоров? Может у вас как тут viewtopic.php?f=44&t=10386

врятли. скрин прилагаю. при этом сессия активна и абонент работает

вот другой скрин
где статус в адеквате

Вы когда строчки с "внимание" из версий вырезали - там про таймзоны не было ничего?

_________________
I'm clever. I've got a computer.

хм. есть такое.
Клиент: вер. 6.0 сборка 1375 от 30.03.2015 19:17:55
os: Windows 7; java: Java HotSpot(TM) Client VM, v.1.7.0_67
ВНИМАНИЕ: Спецификация версии 1.7 не рекомендуется
ВНИМАНИЕ: Необходимо обновить таймзоны
Сервер: вер. 6.0 сборка 1845 от 09.04.2015 12:50:15
os: Linux; java: OpenJDK Client VM, v.1.6.0_27
ВНИМАНИЕ: Виртуальная машина OpenJDK Client VM не рекомендуется
ВНИМАНИЕ: Необходимо обновить таймзоны

root@billing:~/BGBillingServer/log# hwclock
Ср. 15 апр. 2015 13:22:05 -0.755225 секунд
root@billing:~/BGBillingServer/log# date -R
Wed, 15 Apr 2015 13:20:53 +0700

в этом причина?время так-то правильно установлено

а что выдает zdump -v Asia/Yekaterinburg | grep 2011
Хотя можете сразу идти сюда viewtopic.php?f=20&t=5995#p44997
Из за таймзон по крайней мере у меня было пару косяков разных вязанных со временем

Asia/Yekaterinburg Sat Mar 26 20:59:59 2011 UTC = Sun Mar 27 01:59:59 2011 YEKT isdst=0 gmtoff=18000
Asia/Yekaterinburg Sat Mar 26 21:00:00 2011 UTC = Sun Mar 27 03:00:00 2011 YEKT isdst=0 gmtoff=21600

Очень может быть, что от этого. Нужно обновить таймзоны на сервере через tzupdater, на клиенте просто java 1.7 обновить на последнюю.

_________________
I'm clever. I've got a computer.

ничего не понимаю
все равно пишет
Сервер: вер. 6.0 сборка 1845 от 09.04.2015 12:50:15
os: Linux; java: OpenJDK Client VM, v.1.6.0_31
ВНИМАНИЕ: Виртуальная машина OpenJDK Client VM не рекомендуется
ВНИМАНИЕ: Необходимо обновить таймзоны
хотя ниже
Клиент:
os: Windows 7 x86, 6.1
java: Java HotSpot(TM) Client VM, v.1.8.0_45
jre home: C:\Program Files\Java\jre1.8.0_45
default tz: 15.04.2015 15:22 GMT+07:00 +0700 (GMT+07:00)
user tz: 15.04.2015 15:22 KRAT +0700 (Asia/Krasnoyarsk)
locale: ru_RU
Сервер:
os: Linux i386, 3.11.0-15-generic
java: OpenJDK Client VM, v.1.6.0_31
jre home: /usr/lib/jvm/java-6-openjdk-i386/jre
default tz: 15.04.2015 15:22 GMT+07:00 +0700 (GMT+07:00)
locale: ru_RU

На СЕРВЕРЕ обновите таймзоны

_________________
Цитаты великих людей
Напишите в helpdesk © stark
повторяю: => хелпдеск => доработка => профит © dimOn
свершилось... © skn
Мой код изящен, лёгок, оригинален, краток. Как прохладный весенний ветерок, как звонкий ручей! © dimOn
Вежливый разработчик © Artur
Эти баги тоже исправлены, как и те, которые еще не написаны © Artur
ну т.е. существует воркэраунд, ок © dimOn

для 6-ой java нет обновления, нужно запускать tzdata.

таймзоны в порядке. проблема осталась, по прежнему неясно почему статус отбражается неправильно

Клиент: вер. 6.0 сборка 1375 от 30.03.2015 19:17:55
os: Windows 7; java: Java HotSpot(TM) Client VM, v.1.8.0_45
ВНИМАНИЕ: Спецификация версии 1.8 не рекомендуется
Сервер: вер. 6.0 сборка 1845 от 09.04.2015 12:50:15
os: Linux; java: OpenJDK Client VM, v.1.6.0_31
ВНИМАНИЕ: Виртуальная машина OpenJDK Client VM не рекомендуется

bill вер. 6.0 сборка 350 от 24.02.2015 20:15:22
card вер. 6.0 сборка 230 от 09.02.2015 18:40:44
dialup вер. 6.0 сборка 408 от 13.02.2015 20:00:06
inet вер. 6.0 сборка 1495 от 07.04.2015 18:17:00
ipn вер. 6.0 сборка 278 от 09.02.2015 18:41:13
npay вер. 6.0 сборка 231 от 13.02.2015 20:00:05
pay вер. сборка от
phone вер. 6.0 сборка 304 от 18.02.2015 15:21:49
reports вер. 6.0 сборка 224 от 30.03.2015 19:04:18
rscm вер. 6.0 сборка 196 от 07.04.2015 18:17:02
ru.bitel.bgbilling.plugins.dispatch вер. 6.0 сборка 160 от 09.02.2015 18:41:29
trayinfo вер. 6.0 сборка 177 от 09.02.2015 18:41:24
voiceip вер. 6.0 сборка 234 от 09.02.2015 18:41:23

Окружение:

Клиент:
os: Windows 7 x86, 6.1
java: Java HotSpot(TM) Client VM, v.1.8.0_45
jre home: C:\Program Files\Java\jre1.8.0_45
default tz: 15.04.2015 19:02 KRAT +0700 (Asia/Krasnoyarsk)
user tz: 15.04.2015 19:02 KRAT +0700 (Asia/Krasnoyarsk)
locale: ru_RU
Сервер:
os: Linux i386, 3.11.0-15-generic
java: OpenJDK Client VM, v.1.6.0_31
jre home: /usr/lib/jvm/java-6-openjdk-i386/jre
default tz: 15.04.2015 19:02 KRAT +0700 (Asia/Krasnoyarsk)
locale: ru_RU

У этого сервиса есть сейчас активная сессия или он пытался подключаться?
Если сейчас пересохранить сервис - состояние меняется?

Создал новый договор. на нем создал сервис. сделал положительный баланс.
Договор Активен, у сервиса статус открыт состояние удален.
access
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetNas - Search by username=624960
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - [username=624960] Authenticated as inetServId:876
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetApplication - TariffOptionMap: {}
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetApplication - inetServ[id=876] balance ok: 500.00 [0]
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetApplication - OptionSet: [5, 13]
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Not found free IP-address in serv
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Set ip from pool
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Write new waiting connection to DB
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - New connection id=561667
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusProcessor - Return code=0
04-15/20:54:00 INFO [rdsLstnr-p-9-t-11] InetRadiusListenerWorker - RESPONSE:
Packet type: Access-Accept
Identifier: 17

делаю статус сервиса закрыт

04-15/21:00:58 INFO [rdsLstnr-p-9-t-20] InetNas - Search by username=624960
04-15/21:00:58 INFO [rdsLstnr-p-9-t-20] InetRadiusProcessor - [username=624960] Authenticated as inetServId:876
04-15/21:00:58 INFO [rdsLstnr-p-9-t-20] InetApplication - inetServ[id=876] status not active (accessCode=0).
04-15/21:00:58 INFO [rdsLstnr-p-9-t-20] InetRadiusProcessor - Return code=20
04-15/21:00:58 INFO [rdsLstnr-p-9-t-20] InetRadiusListenerWorker - RESPONSE:
Packet type: Access-Reject
Identifier: 45
Authenticator: {9F 82 70 1B CE 8E AC C5 3A 68 7A D9 E9 19 40 66}
Attributes:
Reply-Message=20

тоесть вродебы отрабатывает нормально. может какойнить синхронизации с циской нет

Состояние удален меняется через некоторое время после создания. Скорее всего вы не заметили, надо подождать и нажать на кнопку обновления.

обычно да, согласен, но тут до сих пор состояние удален.(прошло 20 минут),
вообщем это почти у всех сервисов.
еще заметил что запросы на разрыв соединения биллинг не шлет

спустя 4 часа проблема решилась. останавливал и поочередно обновлял access и accounting, перекомпилил CoA ServiceActivator,
все статусы сразу стали адекватными, CoA запросы стал слать. Кажется мне что все таки что то с активатором сервисов было.
На выходных буду до 6.2 обновляться.

Спасибо всем.

Мы не рекомендуем обновляться на выходных, так как скорее всего не будем доступны.
И при обновлении рекомендуем сначала производить обновление на тестовом стенде.