С периодичностью сталкиваемся с такой проблемой.
После пополнения счета абонентом и автоматической переактивацией сервиса с новыми атрибутами прилетает 44 ошибка (Доступ приостановлен). Бывает очень редко но стабильно. Если вызвать serviceModify руками пересохранив сервис то ошибки уже нет и все отрабатывает по сценарию.
Логи инетакцеса в этот момент:
Цитата:
mq 04-16/16:34:30 INFO [event-proc-p-2-t-1] ContractRuntimeMap - Taked event: Event[ru.bitel.bgbilling.kernel.event.events.ContractStatusChangedTopicEvent] moduleId: 0; pluginId: no; cid: 16816; scid: -1; userId: 0; timestamp: 1397640856451
mq 04-16/16:34:30 INFO [event-proc-p-2-t-1] ContractRuntimeMap - Taked event: Event[ru.bitel.bgbilling.kernel.event.events.ContractStatusModifiedEvent] moduleId: 0; pluginId: no; cid: 16816; scid: -1; userId: 0; timestamp: 1397640856402
mq 04-16/16:34:30 INFO [event-proc-p-2-t-1] InetServRuntimeMap - Taked event: Event[ru.bitel.bgbilling.kernel.event.events.ContractStatusModifiedEvent] moduleId: 0; pluginId: no; cid: 16816; scid: -1; userId: 0; timestamp: 1397640856402
mq 04-16/16:34:30 INFO [event-proc-p-2-t-1] ContractRuntimeMap - Taked event: Event[ru.bitel.bgbilling.kernel.event.events.ContractStatusModifiedEvent] moduleId: 0; pluginId: no; cid: 16816; scid: -1; userId: 0; timestamp: 1397640856402
mq 04-16/16:34:30 INFO [event-proc-p-2-t-1] InetServRuntimeMap - Taked event: Event[ru.bitel.bgbilling.kernel.event.events.ContractStatusModifiedEvent] moduleId: 0; pluginId: no; cid: 16816; scid: -1; userId: 0; timestamp: 1397640856402
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorSet - Connecting to device
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Do task deviceId: 53; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaStateModifyEvent] moduleId: 15; pluginId: no; cid: 16816; scid: -1; userId: 0; deviceId: 53; inetServId: 2013; connectionId: 0; state: 1; accessCode: 0; timestamp: 1397640863113
connection 04-16/16:34:37 INFO [sa-p-13-t-16] InetApplication - TariffOptionMap: {}
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=2; inetServId: 2013; call: true; oldState: 0; newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Processing deviceId:53; command ServiceActivatorEvent type=2; inetServId: 2013; call: true; oldState: 0; newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorSet - Invoking serviceModify
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorAdapter - MY SCRIIIIPT! serviceModify 2013 с сервисом договора
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Process event type[2] result=true
connection 04-16/16:34:37 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Changing InetServ:2013 state and/or options
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] RadiusListenerWorker - REQUEST:
Packet type: Access-Request
Identifier: 176
Authenticator: {5C CA C3 D5 E0 34 1E 12 9C 9F C2 85 5D C8 87 02}
Attributes:
User-Name=2013
NAS-Port-Id=lg id 25 clips 2013
NAS-Identifier=Redback-IPOE
User-Password=Redback
NAS-IP-Address=10.1.1.1
NAS-Port=-1761605905
Service-Type=5
NAS-Port-Type=5
Platform-Type=4
Medium-Type=11
OS-Version=11.1.2.6p4
NAS-Real-Port=34603008
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] InetNas - Search by username=2013
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] InetRadiusProcessor - [username=2013] Authenticated as inetServId:2013
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] InetApplication - inetServ[id=2013] deviceState not active (accessCode=44).
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] InetRadiusProcessor - Return code=0
mq 04-16/16:34:38 INFO [event-proc-p-2-t-1] InetServRuntimeMap - Taked event: Event[ru.bitel.bgbilling.modules.inet.access.event.InetServDeviceStateAndOptionsModifiedEvent]
moduleId: 15; pluginId: no; cid: global; scid: -1; userId: -1; deviceId: 53; inetServId: 2013; state: 1; optionSet: ; timestamp: 1397640877381
connection 04-16/16:34:38 INFO [sa-p-13-t-16] ServiceActivatorDeviceWorker - Do task deviceId: 53; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaStateModifyEv
ent] moduleId: 15; pluginId: no; cid: 16816; scid: -1; userId: 0; deviceId: 53; inetServId: 2013; connectionId: 0; state: 1; accessCode: 0; timestamp: 1397640863563
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] HourlyDataLogEntry - Create dataLog file: /usr/local/BGInetAccess/data/radius/source_2/2014/2014-04/2014-04-16/log_2014-04-16-
16.002.bgdl
radius 04-16/16:34:38 INFO [rdsLstnr-p-9-t-9] InetRadiusListenerWorker - RESPONSE:
Packet type: Access-Accept
Identifier: 176
Authenticator: {53 90 E2 B7 BB 23 5B 6F 4C 18 E1 C3 8C 68 40 C1}
Attributes:
Reply-Message=44
Framed-IP-Address=10.50.145.66
Forward-Policy=in:HTTP-REDIRECT
HTTP-Redirect-Profile-Name=noauth
IP-Interface-Name=2core
Process time auth: 7
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorSet - Connecting to device
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Do task deviceId: 2; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEven
t] moduleId: 15; pluginId: no; cid: 16816; scid: -1; userId: 0; type: 2; deviceId: 2; connectionId: 417771; timestamp: 1397640878098
connection 04-16/16:34:38 INFO [sa-p-13-t-45] InetApplication - TariffOptionMap: {}
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=5; inetServId: 2013; call: true; oldState: 1;
newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Processing deviceId:2; command ServiceActivatorEvent type=5; inetServId: 2013; call: true; oldS
tate: 1; newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorSet - Invoking onAccountingStop
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorAdapter - MY SCRIIIIPT! onAccountingStop
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Process event type[5] result=true
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Do task deviceId: 2; Event[ru.bitel.bgbilling.modules.inet.access.sa.event.InetSaAccountingEven
t] moduleId: 15; pluginId: no; cid: 16816; scid: -1; userId: 0; type: 1; deviceId: 2; connectionId: 417869; timestamp: 1397640878254
connection 04-16/16:34:38 INFO [sa-p-13-t-45] InetApplication - TariffOptionMap: {}
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=4; inetServId: 2013; call: true; oldState: 1;
newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Processing deviceId:2; command ServiceActivatorEvent type=4; inetServId: 2013; call: true; oldS
tate: 1; newState: 1; oldOptionSet: 7; newOptionSet: 7
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorSet - Invoking onAccountingStart
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorAdapter - MY SCRIIIIPT! onAccountingStart
connection 04-16/16:34:38 INFO [sa-p-13-t-45] ServiceActivatorDeviceWorker - Process event type[4] result=true
mq 04-16/16:34:38 INFO [event-proc-p-2-t-1] InetConnectionManager - Remove connection: InetConnection [id=417771-0, iface=2:-1761605905, sessId=FF160019480006EF-534D6812, s
tart=16.04.2014 00:10:42, uname=2013, addr=10.50.145.66]
mq 04-16/16:34:38 INFO [event-proc-p-2-t-1] InetConnectionManager - Add connection: InetConnection [id=417869-0, iface=2:-1761605905, sessId=FF160019480006EF-534E4EA6, star
t=16.04.2014 16:34:38, uname=2013, addr=10.50.145.66]
Версия:
Цитата:
Сервер: вер. 5.2 сборка 1359 от 02.12.2012 16:15:29
os: Linux; java: Java HotSpot(TM) 64-Bit Server VM, v.1.6.0_38
inet вер. 5.2 сборка 1027 от 29.11.2012 19:15:37
Версия старая мб бага с асинхронностью какаята? Прошу помощи.
Вход
Регистрация
FAQ
Поиск
