forum.bitel.ru
http://forum.bitel.ru/

Нулевой трафик
http://forum.bitel.ru/viewtopic.php?f=44&t=9061		 Страница 1 из 1
Автор:  sergey-xxi [ 19 мар 2014, 19:11 ]
Заголовок сообщения:  Нулевой трафик
Используем CLIPS с авторизацией по порту коммутатора. Заметили у некоторых абонентов нулевой трафик, по нулевым сессиям в биллинге отсутствуют сервисные сессии, хотя на редбеке эти сессии есть и у абонентов связь тоже есть. Где можно искать проблему?
Автор:  Amir [ 19 мар 2014, 19:20 ]
Заголовок сообщения:  Re: Нулевой трафик
Посмотрите в логах InetAccounting что происходит, когда приходит UPDATE-пакет по какой-либо из этих сервисных сессий, которые в Redback есть, но в биллинге нет.
Автор:  sergey-xxi [ 19 мар 2014, 19:39 ]
Заголовок сообщения:  Re: Нулевой трафик
Update-пакет из одной такой сессии:
Код:
radius 03-19/17:22:12  INFO [rdsLstnr-p-8-t-7] update - REQUEST:
Packet type: Accounting-Request
Identifier: 216
Authenticator: {5D 52 B3 4B 39 53 5A 38 37 DC 7A 6F 2C B1 38 81}
Attributes:
  User-Name=a8:f9:4b:07:9a:da
  NAS-Identifier=RedBack
  NAS-IP-Address=192.168.12.247
  NAS-Port=33751040
  Service-Type=5
  Acct-Input-Octets=1514605375
  Acct-Output-Octets=-459045948
  Acct-Status-Type=3
  Acct-Session-Time=2503813
  Acct-Input-Packets=-1982870825
  Acct-Session-Id=0102FFFF78000CBD-5303627D
  Acct-Authentic=1
  Acct-Interim-Interval=900
  NAS-Port-Id=2/3 clips 156572
  Acct-Output-Packets=1572832430
  Event-Timestamp=1395234558
  Acct-Output-Gigawords=186
  Acct-Input-Gigawords=734
  NAS-Port-Type=5
  Called-Station-Id=10.21.146.1
  Acct-Mcast-Out-Packets-64={00 00 00 00 00 00 00 00}
  DHCP-Max-Leases=1
  UNKNOWN[2352-201]={01 0A 15 92 01}
  Acct-Output-Octets-64={00 00 00 BA E4 A3 83 C4}
  Acct-Input-Octets-64={00 00 02 DE 5A 47 0B 3F}
  Acct-Output-Packets-64={00 00 00 00 5D BF 84 AE}
  Acct-Input-Packets-64={00 00 00 00 89 CF CA D7}
  Acct-Mcast-In-Octets-64={00 00 00 00 00 00 00 00}
  Assigned-IP-Address=10.21.146.123
  Acct-Mcast-In-Packets-64={00 00 00 00 00 00 00 00}
  Acct-Mcast-Out-Octets-64={00 00 00 00 00 00 00 00}
  Qos-Policing-Profile-Name=DEF-IPOE-IN
  Acct-Update-Reason=3
  Mac-Addr=a8-f9-4b-07-9a-da
  Acct-Mcast-In-Octets=0
  Acct-Mcast-Out-Octets=0
  Qos-Metering-Profile-Name=DEF-IPOE-OUT
  Acct-Mcast-In-Packets=0
  Acct-Mcast-Out-Packets=0
  Platform-Type=4
  Medium-Type=11
  Agent-Remote-Id={00 00 00 00 06 A8 F9 4B 80 57 72}
  Agent-Circuit-Id={21 09 04 7A 00 00 00 00 00 00 04}
  IP-Interface-Name=clients
  NAT-Policy-Name=nat-policy
  OS-Version=6.5.1.5
  NAS-Real-Port=33751040
  UNKNOWN[3561--1]={02 0D 00 00 00 00 06 A8 F9 4B 80 57 72}
  UNKNOWN[3561--1]={01 0D 21 09 04 7A 00 00 00 00 00 00 04}

radius 03-19/17:22:12  INFO [rdsLstnr-p-8-t-7] SmartEdgeClipsProtocolHandler - Parse as eltex bytes
radius 03-19/17:22:12  INFO [rdsLstnr-p-8-t-7] InetRadiusProcessor - REQUEST_AFTER_PREPROCESS:
Packet type: Accounting-Request
Identifier: 216
Authenticator: {5D 52 B3 4B 39 53 5A 38 37 DC 7A 6F 2C B1 38 81}
Attributes:
  User-Name=0000000006a8f94b805772:2109047a00000000000004
  NAS-Identifier=RedBack
  NAS-IP-Address=192.168.12.247
  NAS-Port=33751040
  Service-Type=5
  Acct-Input-Octets=1514605375
  Acct-Output-Octets=-459045948
  Acct-Status-Type=3
  Acct-Session-Time=2503813
  Acct-Input-Packets=-1982870825
  Acct-Session-Id=0102FFFF78000CBD-5303627D
  Acct-Authentic=1
  Acct-Interim-Interval=900
  NAS-Port-Id=2/3 clips 156572
  Acct-Output-Packets=1572832430
  Event-Timestamp=1395234558
  Acct-Output-Gigawords=186
  Acct-Input-Gigawords=734
  Calling-Station-Id=a8f94b079ada
  NAS-Port-Type=5
  Called-Station-Id=10.21.146.1
  Acct-Mcast-Out-Packets-64={00 00 00 00 00 00 00 00}
  DHCP-Max-Leases=1
  UNKNOWN[2352-201]={01 0A 15 92 01}
  Acct-Output-Octets-64={00 00 00 BA E4 A3 83 C4}
  Acct-Input-Octets-64={00 00 02 DE 5A 47 0B 3F}
  Acct-Output-Packets-64={00 00 00 00 5D BF 84 AE}
  Acct-Input-Packets-64={00 00 00 00 89 CF CA D7}
  Acct-Mcast-In-Octets-64={00 00 00 00 00 00 00 00}
  Assigned-IP-Address=10.21.146.123
  Acct-Mcast-In-Packets-64={00 00 00 00 00 00 00 00}
  Acct-Mcast-Out-Octets-64={00 00 00 00 00 00 00 00}
  Qos-Policing-Profile-Name=DEF-IPOE-IN
  Acct-Update-Reason=3
  Mac-Addr=a8-f9-4b-07-9a-da
  Acct-Mcast-In-Octets=0
  Acct-Mcast-Out-Octets=0
  Qos-Metering-Profile-Name=DEF-IPOE-OUT
  Acct-Mcast-In-Packets=0
  Acct-Mcast-Out-Packets=0
  Platform-Type=4
  Medium-Type=11
  Agent-Remote-Id={00 00 00 00 06 A8 F9 4B 80 57 72}
  Agent-Circuit-Id={21 09 04 7A 00 00 00 00 00 00 04}
  IP-Interface-Name=clients
  NAT-Policy-Name=nat-policy
  OS-Version=6.5.1.5
  NAS-Real-Port=33751040
  UNKNOWN[3561--1]={02 0D 00 00 00 00 06 A8 F9 4B 80 57 72}
  UNKNOWN[3561--1]={01 0D 21 09 04 7A 00 00 00 00 00 00 04}
Common options: {agentRemoteId={a8f94b805772}, agentCircuitId={2109047a00000000000004}}
radius 03-19/17:22:12  INFO [rdsLstnr-p-8-t-7] InetRadiusProcessor - Session 0102FFFF78000CBD-5303627D found.
radius 03-19/17:22:12  INFO [rdsLstnr-p-8-t-7] update - RESPONSE:
Packet type: Accounting-Response
Identifier: 216
Authenticator: {14 99 F2 42 CF 5C 39 B1 98 8E 63 5E B5 7D 12 06}
Attributes:

Process time update: 1
Автор:  Amir [ 19 мар 2014, 19:47 ]
Заголовок сообщения:  Re: Нулевой трафик
Это аккаунтинг по родительской сессии. У сервисной должен быть Acct-Status-Type=103 и, вроде бы Acct-Multi-Session-Id=0102FFFF78000CBD-5303627D (для этой сессии).
Автор:  sergey-xxi [ 19 мар 2014, 19:58 ]
Заголовок сообщения:  Re: Нулевой трафик
Код:
radius 03-19/17:36:39  INFO [rdsLstnr-p-8-t-4] RadiusListenerWorker - REQUEST:
Packet type: Accounting-Request
Identifier: 118
Authenticator: {67 F5 36 3F 0A 23 34 06 56 F0 FD BE 03 34 9F F4}
Attributes:
  User-Name=a8:f9:4b:07:9a:da
  NAS-Identifier=RedBack
  NAS-IP-Address=192.168.12.247
  NAS-Port=33751040
  Service-Type=5
  Acct-Input-Octets=-409696209
  Acct-Output-Octets=-993579057
  Acct-Status-Type=103
  Acct-Session-Time=2504681
  Acct-Input-Packets=-1982502050
  Acct-Session-Id=0102FFFF78000CBD-5303627D-SE-BFA306F1
  Acct-Authentic=1
  Acct-Interim-Interval=900
  Acct-Multi-Session-Id=0102FFFF78000CBD-5303627D
  NAS-Port-Id=2/3 clips 156572
  Acct-Output-Packets=1573000497
  Event-Timestamp=1395235426
  Acct-Output-Gigawords=181
  Acct-Input-Gigawords=726
  NAS-Port-Type=5
  Called-Station-Id=10.21.146.1
  Acct-Mcast-Out-Packets-64={00 00 00 00 00 00 00 00}
  DHCP-Max-Leases=1
  UNKNOWN[2352-201]={01 0A 15 92 01}
  Acct-Output-Octets-64={00 00 00 B5 C4 C7 2F CF}
  Acct-Input-Octets-64={00 00 02 D6 E7 94 88 2F}
  Acct-Output-Packets-64={00 00 00 00 5D C2 15 31}
  Acct-Input-Packets-64={00 00 00 00 89 D5 6B 5E}
  Acct-Mcast-In-Octets-64={00 00 00 00 00 00 00 00}
  Service-Parameter=Rate=150000 Burst=18750000
  Assigned-IP-Address=10.21.146.123
  Acct-Mcast-In-Packets-64={00 00 00 00 00 00 00 00}
  Acct-Mcast-Out-Octets-64={00 00 00 00 00 00 00 00}
  Acct-Update-Reason=26
  Mac-Addr=a8-f9-4b-07-9a-da
  Acct-Mcast-In-Octets=0
  Acct-Mcast-Out-Octets=0
  Acct-Mcast-In-Packets=0
  Acct-Mcast-Out-Packets=0
  Platform-Type=4
  Medium-Type=11
  Agent-Remote-Id={00 00 00 00 06 A8 F9 4B 80 57 72}
  Agent-Circuit-Id={21 09 04 7A 00 00 00 00 00 00 04}
  IP-Interface-Name=clients
  Service-Name=SE
  Service-Options:0=1
  OS-Version=6.5.1.5
  NAS-Real-Port=33751040
  UNKNOWN[3561--1]={02 0D 00 00 00 00 06 A8 F9 4B 80 57 72}
  UNKNOWN[3561--1]={01 0D 21 09 04 7A 00 00 00 00 00 00 04}

radius 03-19/17:36:39  INFO [rdsLstnr-p-8-t-4] InetRadiusProcessor - REQUEST_AFTER_PREPROCESS:
Packet type: Accounting-Request
Identifier: 118
Authenticator: {67 F5 36 3F 0A 23 34 06 56 F0 FD BE 03 34 9F F4}
Attributes:
  User-Name=a8:f9:4b:07:9a:da
  NAS-Identifier=RedBack
  NAS-IP-Address=192.168.12.247
  NAS-Port=33751040
  Service-Type=5
  Acct-Input-Octets=-409696209
  Acct-Output-Octets=-993579057
  Acct-Status-Type=3
  Acct-Session-Time=2504681
  Acct-Input-Packets=-1982502050
  Acct-Session-Id=0102FFFF78000CBD-5303627D-SE-BFA306F1
  Acct-Authentic=1
  Acct-Interim-Interval=900
  Acct-Multi-Session-Id=0102FFFF78000CBD-5303627D
  NAS-Port-Id=2/3 clips 156572
  Acct-Output-Packets=1573000497
  Event-Timestamp=1395235426
  Acct-Output-Gigawords=181
  Acct-Input-Gigawords=726
  NAS-Port-Type=5
  Called-Station-Id=10.21.146.1
  Acct-Mcast-Out-Packets-64={00 00 00 00 00 00 00 00}
  DHCP-Max-Leases=1
  UNKNOWN[2352-201]={01 0A 15 92 01}
  Acct-Output-Octets-64={00 00 00 B5 C4 C7 2F CF}
  Acct-Input-Octets-64={00 00 02 D6 E7 94 88 2F}
  Acct-Output-Packets-64={00 00 00 00 5D C2 15 31}
  Acct-Input-Packets-64={00 00 00 00 89 D5 6B 5E}
  Acct-Mcast-In-Octets-64={00 00 00 00 00 00 00 00}
  Service-Parameter=Rate=150000 Burst=18750000
  Assigned-IP-Address=10.21.146.123
  Acct-Mcast-In-Packets-64={00 00 00 00 00 00 00 00}
  Acct-Mcast-Out-Octets-64={00 00 00 00 00 00 00 00}
  Acct-Update-Reason=26
  Mac-Addr=a8-f9-4b-07-9a-da
  Acct-Mcast-In-Octets=0
  Acct-Mcast-Out-Octets=0
  Acct-Mcast-In-Packets=0
  Acct-Mcast-Out-Packets=0
  Platform-Type=4
  Medium-Type=11
  Agent-Remote-Id={00 00 00 00 06 A8 F9 4B 80 57 72}
  Agent-Circuit-Id={21 09 04 7A 00 00 00 00 00 00 04}
  IP-Interface-Name=clients
  Service-Name=SE
  Service-Options:0=1
  OS-Version=6.5.1.5
  NAS-Real-Port=33751040
  UNKNOWN[3561--1]={02 0D 00 00 00 00 06 A8 F9 4B 80 57 72}
  UNKNOWN[3561--1]={01 0D 21 09 04 7A 00 00 00 00 00 00 04}
Common options: {parentAcctSessionId=0102FFFF78000CBD-5303627D, serviceName=SE}
radius 03-19/17:36:39  INFO [rdsLstnr-p-8-t-4] InetRadiusProcessor - Session 0102FFFF78000CBD-5303627D-SE-BFA306F1 found.
radius 03-19/17:36:39  INFO [rdsLstnr-p-8-t-4] RadiusListenerWorker - RESPONSE:
Packet type: Accounting-Response
Identifier: 118
Authenticator: {C5 45 5B 08 34 20 EF 6C 4C 1B E0 A3 FE 27 AC 8F}
Attributes:
0
Автор:  Amir [ 19 мар 2014, 20:03 ]
Заголовок сообщения:  Re: Нулевой трафик
Странно, но пишет, что Session 0102FFFF78000CBD-5303627D-SE-BFA306F1 found.
Этой сессии точно нет в дочерних?
Попробуйте тогда найти сессию SQL-запросом SELECT * FROM inet_connection_<mid> WHERE acctSessionId="0102FFFF78000CBD-5303627D-SE-BFA306F1".
Если ли она вообще в БД, принадлежит ли тому же сервису, какая у нее родительская сессия (parentId).
Автор:  sergey-xxi [ 20 мар 2014, 11:39 ]
Заголовок сообщения:  Re: Нулевой трафик
Сервисных (дочерних) сессий, если верить клиенту биллинга, у этой сессии нет. В базе сессии с таким ID тоже нет, есть только родительская с идентификатором "0102FFFF78000CBD-5303627D".
В этой таблице хранятся все активные сессии? Смущает то, что некоторым сессиям уже больше полгода.
Автор:  sergey-xxi [ 20 мар 2014, 12:00 ]
Заголовок сообщения:  Re: Нулевой трафик
В таблице inet_session_log по этой сессии до определенного времени были и родительская и сервисная сессия, но уже почти месяц сервисной сессии нет. Единственное подозрительное в этой таблице, что у последней сервисной сессии время окончания не как обычно 23:59:59, а на минуту больше.
Вложение:
inet_session_log.txt [5.23 КБ]
Скачиваний: 468
Автор:  Amir [ 20 мар 2014, 16:40 ]
Заголовок сообщения:  Re: Нулевой трафик
У вас один InetAccounting сервер?
Попробуйте завершить (зависшее) соединение через контекстное меню - нормально завершается или ошибки в логах?
Если нормально, после следующего апдейта должно стать нормально.

Сейчас как-будто Accounting считает что сессия есть (т.е. она есть у него в памяти), но в БД её почему-то нет.
Автор:  sergey-xxi [ 21 мар 2014, 00:27 ]
Заголовок сообщения:  Re: Нулевой трафик
Сервер InetAccounting у нас один. После принудительного завершения сессии через клиент биллинга в логах ничего подозрительного нет. Есть ли возможность завершить все сессии сразу?
Зато в логах много подобных ошибок:
Код:
accounting 03-20/22:08:40  INFO [accwrkr-3-p-10-t-1] connection - 473446:705797 Finish stopped call connection by sessionFinishTimeout
accounting 03-20/22:08:40  INFO [accwrkr-3-p-10-t-1] connection - 473446:705797 Finishing call session with lastActive=Sat Mar 01 01:26:28 MSK 2014
accounting 03-20/22:08:40  INFO [accwrkr-3-p-10-t-1] Accounting - Finishing session 705797
accounting 03-20/22:08:40 ERROR [accwrkr-3-p-10-t-1] SessionFlushingManager - Cannot find session with id=705797 in DB!
accounting 03-20/22:08:40 ERROR [accwrkr-3-p-10-t-1] WorkerTask - com.mysql.jdbc.exceptions.jdbc4.MySQLIntegrityConstraintViolationException: Duplicate entry '705797-28
-23-0-0' for key 'PRIMARY'
ru.bitel.bgbilling.common.BGException: com.mysql.jdbc.exceptions.jdbc4.MySQLIntegrityConstraintViolationException: Duplicate entry '705797-28-23-0-0' for key 'PRIMARY'
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFlushingManager.flush(SessionFlushingManager.java:498)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.sessionFinish(Accounting.java:1693)
        at ru.bitel.bgbilling.modules.inet.accounting.InetConnectionCallRuntime.finish(InetConnectionCallRuntime.java:369)
        at ru.bitel.bgbilling.modules.inet.accounting.InetConnectionCallRuntime.tryFinish(InetConnectionCallRuntime.java:339)
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFinishManager.runImpl(SessionFinishManager.java:99)
        at ru.bitel.common.worker.WorkerTask.run(WorkerTask.java:86)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:439)
        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:895)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:918)
        at java.lang.Thread.run(Thread.java:662)
        at ru.bitel.common.worker.WorkerThread.run(WorkerThread.java:40)
Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLIntegrityConstraintViolationException: Duplicate entry '705797-28-23-0-0' for key 'PRIMARY'
        at sun.reflect.GeneratedConstructorAccessor1652.newInstance(Unknown Source)
        at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
        at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
        at com.mysql.jdbc.Util.handleNewInstance(Util.java:411)
        at com.mysql.jdbc.Util.getInstance(Util.java:386)
        at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:1039)
        at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3609)
        at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3541)
        at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2002)
        at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2163)
        at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2624)
        at com.mysql.jdbc.PreparedStatement.executeInternal(PreparedStatement.java:2127)
        at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:2427)
        at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:2345)
        at com.mysql.jdbc.PreparedStatement.executeUpdate(PreparedStatement.java:2330)
        at org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:105)
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFlushingManager.merge(SessionFlushingManager.java:941)
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFlushingManager.flush(SessionFlushingManager.java:453)
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFlushingManager.merge(SessionFlushingManager.java:941)
        at ru.bitel.bgbilling.modules.inet.accounting.SessionFlushingManager.flush(SessionFlushingManager.java:453)
        ... 15 more
Автор:  Amir [ 21 мар 2014, 11:14 ]
Заголовок сообщения:  Re: Нулевой трафик
У вас все таблицы в InnoDB?
Автор:  sergey-xxi [ 22 мар 2014, 19:19 ]
Заголовок сообщения:  Re: Нулевой трафик
В общем выяснили, мы переносили базу на новый сервер, где версия mysql 5.1 в которой параметр "default-storage-engine" более не поддерживается из-за этого в базе появились таблицы в myisam.
таблица inet_session_log с нового месяца начала создаваться в myisam.
Будет ли достаточно установить в настройках базы параметр: "default-table-type=Innodb", чтобы устранить глюк?
Или придется еще и переконвертировать уже созданные таблицы?
Автор:  Amir [ 22 мар 2014, 19:46 ]
Заголовок сообщения:  Re: Нулевой трафик
Лучше переконвертировать. Myisam не поддерживает транзакции, а inet их во всю использует.
Страница 1 из 1 Часовой пояс: UTC + 5 часов [ Летнее время ]
Powered by phpBB® Forum Software © phpBB Group
http://www.phpbb.com/