Здравствуйте!
Подскажите в чем может быть проблема? У пользователей отвязывается рабочий сервис и привязывается INET_FAKE.
1. Авторизация на основе mac коммутатора + номер порта, cisco в качестве dhcp-relay.
2. Абонент включает ПК, сессия поднимается с рабочими параметрами.
3. Проходит произвольное кол-во времени и у абонента биллинг отвязывает сервис с инетом, привязывает ему INET_FAKE.
В дебаге radius aaa coa это видно:
Код:
May 22 10:19:01.236: ++++++ CoA Attribute List ++++++
May 22 10:19:01.236: 58474D54 0 00000001 session-id(410) 4 28320(6EA0)
May 22 10:19:01.236: 58474C9C 0 00000009 ssg-command-code(488) 11 0C 6C 34 72 65 64 69 72 65 63 74
May 22 10:19:01.236:
May 22 10:20:01.249: COA: 10.1.20.200 request queued
May 22 10:20:01.249: COA: 10.1.20.200 request queued
May 22 10:20:01.249: COA: 10.1.20.200 request queued
May 22 10:20:01.249: COA: This packet is likely a retransmission using an existing ident = 162, client 10.1.20.200
May 22 10:20:01.249: RADIUS: authenticator 60 E1 69 58 29 4D 90 71 - CC CC F8 0A D5 32 F8 16
May 22 10:20:01.249: RADIUS: Acct-Session-Id [44] 29 "15/0/2/210_8A00000000006EC2"
May 22 10:20:01.249: RADIUS: Vendor, Cisco [26] 19
May 22 10:20:01.249: RADIUS: ssg-command-code [252] 13
May 22 10:20:01.249: RADIUS: 0C 53 50 45 45 44 5F 32 30 4D 42 [Service-Log-Off SPEED_20MB]
May 22 10:20:01.249: COA: Message Authenticator missing or failed decode
May 22 10:20:01.249: ++++++ CoA Attribute List ++++++
May 22 10:20:01.249: 58474EC4 0 00000001 session-id(410) 4 28354(6EC2)
May 22 10:20:01.249: 58474A74 0 00000009 ssg-command-code(488) 11 0C 53 50 45 45 44 5F 32 30 4D 42
May 22 10:20:01.249:
May 22 10:20:01.250: COA: This packet is likely a retransmission using an existing ident = 163, client 10.1.20.200
May 22 10:20:01.250: RADIUS: authenticator 02 95 7A 0C 16 42 14 51 - 1A 51 35 44 2A 14 F6 FC
May 22 10:20:01.250: RADIUS: Acct-Session-Id [44] 29 "15/0/2/210_8A00000000006EC2"
May 22 10:20:01.250: RADIUS: Vendor, Cisco [26] 18
May 22 10:20:01.250: RADIUS: ssg-command-code [252] 12
May 22 10:20:01.250: RADIUS: 0B 49 4E 45 54 5F 46 41 4B 45 [Service-Log-On INET_FAKE]
May 22 10:20:01.250: COA: Message Authenticator missing or failed decode
May 22 10:20:01.250: ++++++ CoA Attribute List ++++++
May 22 10:20:01.250: 5847B084 0 00000001 session-id(410) 4 28354(6EC2)
May 22 10:20:01.250: 58474B88 0 00000009 ssg-command-code(488) 10 0B 49 4E 45 54 5F 46 41 4B 45
May 22 10:20:01.250:
May 22 10:20:01.250: COA: This packet is likely a retransmission using an existing ident = 164, client 10.1.20.200
May 22 10:20:01.250: RADIUS: authenticator D2 17 5C 62 D6 DB B0 B4 - 75 38 46 49 74 AF F5 06
May 22 10:20:01.250: RADIUS: Acct-Session-Id [44] 29 "15/0/2/210_8A00000000006EC2"
May 22 10:20:01.250: RADIUS: Vendor, Cisco [26] 19
May 22 10:20:01.250: RADIUS: ssg-command-code [252] 13
May 22 10:20:01.250: RADIUS: 0B 6C 34 72 65 64 69 72 65 63 74 [Service-Log-On l4redirect]
May 22 10:20:01.250: COA: Message Authenticator missing or failed decode
May 22 10:20:01.250: ++++++ CoA Attribute List ++++++
May 22 10:20:01.250: 584757C0 0 00000001 session-id(410) 4 28354(6EC2)
May 22 10:20:01.250: 58474FD8 0 00000009 ssg-command-code(488) 11 0B 6C 34 72 65 64 69 72 65 63 74
May 22 10:20:01.250:
May 22 10:20:01.410: COA: 10.1.20.200 request queued
May 22 10:20:01.410: COA: 10.1.20.200 request queued
May 22 10:20:01.410: COA: This packet is likely a retransmission using an existing ident = 165, client 10.1.20.200
May 22 10:20:01.410: RADIUS: authenticator 9A 51 F0 93 B6 92 C2 36 - 8A 4E C1 3F 20 EC 26 64
May 22 10:20:01.410: RADIUS: Acct-Session-Id [44] 29 "15/0/2/210_8A00000000006EC2"
May 22 10:20:01.410: RADIUS: Vendor, Cisco [26] 18
May 22 10:20:01.410: RADIUS: ssg-command-code [252] 12
May 22 10:20:01.410: RADIUS: 0C 49 4E 45 54 5F 46 41 4B 45 [Service-Log-Off INET_FAKE]
May 22 10:20:01.410: COA: Message Authenticator missing or failed decode
May 22 10:20:01.410: ++++++ CoA Attribute List ++++++
May 22 10:20:01.410: 584757C0 0 00000001 session-id(410) 4 28354(6EC2)
May 22 10:20:01.410: 5847A840 0 00000009 ssg-command-code(488) 10 0C 49 4E 45 54 5F 46 41 4B 45
May 22 10:20:01.410:
May 22 10:20:01.410: COA: This packet is likely a retransmission using an existing ident = 166, client 10.1.20.200
May 22 10:20:01.410: RADIUS: authenticator FF 4C 79 E1 59 C0 26 20 - 20 78 94 CF E6 A8 92 5C
May 22 10:20:01.410: RADIUS: Acct-Session-Id [44] 29 "15/0/2/210_8A00000000006EC2"
May 22 10:20:01.410: RADIUS: Vendor, Cisco [26] 19
May 22 10:20:01.410: RADIUS: ssg-command-code [252] 13
May 22 10:20:01.410: RADIUS: 0C 6C 34 72 65 64 69 72 65 63 74 [Service-Log-Off l4redirect]
May 22 10:20:01.410: COA: Message Authenticator missing or failed decode
Если эту сессию сбросить с консоли cisco, то сессия заново поднимется с рабочими параметрами, но по истечении некоторого времени все повторится и абонента заблокирует.
В логах есть такое:
error.log
Код:
connection 05-22/17:03:27 ERROR [sa-p-7-t-18] EventWorker - [Ljava.lang.Object; cannot be cast to ru.bitel.bgbilling.kernel.event.Event
java.lang.ClassCastException: [Ljava.lang.Object; cannot be cast to ru.bitel.bgbilling.kernel.event.Event
at ru.bitel.bgbilling.kernel.event.EventWorker.internalDoTask(EventWorker.java:186)
at ru.bitel.bgbilling.kernel.event.AsyncEventWorker.doTasks(AsyncEventWorker.java:75)
at ru.bitel.bgbilling.modules.inet.access.sa.ServiceActivatorDeviceWorker.runWorker(ServiceActivatorDeviceWorker.java:158)
at ru.bitel.bgbilling.kernel.event.EventWorker.internalRunWorker(EventWorker.java:113)
at ru.bitel.bgbilling.modules.inet.access.sa.ServiceActivatorDeviceWorker.runImpl(ServiceActivatorDeviceWorker.java:102)
at ru.bitel.common.worker.WorkerTask.run(WorkerTask.java:86)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:662)
at ru.bitel.common.worker.WorkerThread.run(WorkerThread.java:40)
connection.log
Код:
05-22/17:00:21 INFO [sa-p-7-t-76] ServiceActivatorDeviceWorker - Command result event: ServiceActivatorEvent type=4; inetServId: 544; call: true; oldState: 1; newState: 1; oldOp
tionSet: 25; newOptionSet: 25
05-22/17:00:21 INFO [sa-p-7-t-76] ServiceActivatorDeviceWorker - Processing deviceId:2; command ServiceActivatorEvent type=4; inetServId: 544; call: true; oldState: 1; newState:
1; oldOptionSet: 25; newOptionSet: 25
05-22/17:00:21 INFO [sa-p-7-t-76] ServiceActivatorSet - Invoking onAccountingStart
05-22/17:00:21 INFO [sa-p-7-t-76] ServiceActivatorDeviceWorker - Process event type[4] result=true
05-22/17:00:21 INFO [pod-support-p1700] RadiusClient - Recieved from /10.1.20.2:1700
Packet type: CoA-ACK
Identifier: 36
Authenticator: {98 75 B4 EF 57 8F D3 84 03 56 53 40 17 2C 9C D4}
Attributes:
cisco-SSG-Command-Code=\0xcSPEED_20MB
cisco-SSG-Account-Info=S31.135.47.67
05-22/17:00:21 INFO [pod-support-p1700] RadiusClient - Recieved from /10.1.20.2:1700
Packet type: CoA-ACK
Identifier: 39
Authenticator: {78 06 E1 47 EE 56 2D 39 34 E6 23 B8 D3 43 85 57}
Attributes:
cisco-SSG-Command-Code=\0xcSPEED_20MB
cisco-SSG-Account-Info=S31.135.47.72
05-22/17:00:21 INFO [pod-support-p1700] RadiusClient - Recieved from /10.1.20.2:1700
Packet type: CoA-ACK
Identifier: 37
Authenticator: {CF 2C A8 6A 49 9B 35 83 B3 C4 43 48 3B CA C5 F0}
Attributes:
cisco-SSG-Command-Code=\0xbINET_FAKE
cisco-SSG-Account-Info=S31.135.47.67
cisco-SSG-Account-Info=$MA0013.d46d.94f1
05-22/17:00:21 INFO [pod-support-p1700] RadiusClient - Recieved from /10.1.20.2:1700
Packet type: CoA-ACK
Identifier: 40
Authenticator: {83 D7 62 3A 7A 48 0D E3 4F 3D CE CA 2A 13 3F CC}
Attributes:
cisco-SSG-Command-Code=\0xbINET_FAKE
cisco-SSG-Account-Info=S31.135.47.72
cisco-SSG-Account-Info=$MAe89a.8fc7.0c69
Получается что рабочий сервис отвязывается, но потом назад не привязывается, что это?
Код:
Сервер: вер. 5.2 сборка 1062 от 20.02.2012 12:51:09
os: Linux; java: Java HotSpot(TM) 64-Bit Server VM, v.1.6.0_29
card вер. 5.2 сборка 158 от 18.01.2012 02:38:36
cerbercrypt вер. 5.2 сборка 172 от 02.02.2012 18:56:17
dialup вер. 5.2 сборка 300 от 20.02.2012 12:51:52
inet вер. 5.2 сборка 731 от 20.02.2012 12:51:41
ipn вер. 5.2 сборка 207 от 17.02.2012 14:55:35
npay вер. 5.2 сборка 157 от 14.02.2012 12:11:02
reports вер. 5.2 сборка 163 от 18.01.2012 02:40:06
ru.bitel.bgbilling.plugins.cashcheck вер. 5.2 сборка 92 от 12.12.2011 15:31:54
ru.bitel.bgbilling.plugins.crm вер. 5.2 сборка 166 от 20.02.2012 16:29:59