BiTel

accounting 03-05/11:03:09  INFO [accwrkr-1-p-12-t-1] InetApplication - TariffOptionMap: {}
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] update - REQUEST:
Packet type: Accounting-Request
Identifier: 69
Authenticator: {D3 CA 0C 5A 97 AF FB 6B 2A 30 25 CF F0 9B 3F AD}
Attributes:
  User-Name=bg@localhost
  NAS-Identifier=router
  NAS-IP-Address=192.168.1.250
  NAS-Port=368161
  Service-Type=2
  Framed-Protocol=1
  Framed-IP-Address=192.168.66.32
  Acct-Input-Octets=74
  Acct-Output-Octets=70
  Acct-Status-Type=3
  Acct-Delay-Time=0
  Acct-Session-Time=48305
  Acct-Input-Packets=8
  Acct-Session-Id=81f07374
  Acct-Authentic=1
  Acct-Output-Packets=7
  Event-Timestamp=1330938191
  Acct-Output-Gigawords=0
  Acct-Input-Gigawords=0
  NAS-Port-Type=5
  Calling-Station-Id=192.168.1.174
  Called-Station-Id=192.168.1.250
  Mikrotik-Realm=localhost
  MS-CHAP-Domain=localhost

radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] HourlyDataLogEntry - Create dataLog file: /usr/local/BGInetAccounting/data/radius/source_5/2012/2012-03/2012-0
3-05/log_2012-03-05-11.000.bgdl
radius 03-05/11:03:11  WARN [rdsLstnr-p-6-t-1] InetRadiusProcessor - Creating NasConnection from accounting packet [statusType=3]
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] InetRadiusProcessor - Connection exist in db
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] InetRadiusProcessor - Session exist in db
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] connection - 4162:4403 Register ip: 192.168.66.32
radius 03-05/11:03:11 ERROR [rdsLstnr-p-6-t-1] InetNas - InetNasConnection is null
radius 03-05/11:03:11 ERROR [rdsLstnr-p-6-t-1] RadiusListenerWorker -
java.lang.NullPointerException
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.setConnection(InetNas.java:239)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.connectionCallStart(InetRadiusProcessor.java:1265)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:1108)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:832)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:296)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accounting(RadiusProcessor.java:508)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accountingRequest(RadiusProcessor.java:445)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:136)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.processPacket(RadiusListenerWorker.java:202)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.runImpl(RadiusListenerWorker.java:88)
        at ru.bitel.common.worker.WorkerTask.run(WorkerTask.java:86)
        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)
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] update - RESPONSE:
Packet type: Accounting-Response
Identifier: 69
Authenticator: {55 02 68 E3 55 E3 CF 99 5B FC C0 EC B6 98 79 50}
Attributes:

Process time update: 18
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - Calculate for 05.03.2012 11:00:00
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - TariffOptionMap: {}
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - InetOptionSet: [1]
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - Calculate for 05.03.2012 11:00:00
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - TariffOptionMap: {}
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] SessionTarifficationManager - InetOptionSet: [1]
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] InetApplication - TariffOptionMap: {}
accounting 03-05/11:03:14  INFO [accwrkr-1-p-12-t-1] InetApplication - TariffOptionMap: {}
accounting 03-05/11:03:44  WARN [accwrkr-3-p-10-t-1] CheckReentrantLock - Object is locked by
java.lang.RuntimeException
        at java.lang.Thread.getStackTrace(Thread.java:1479)
        at ru.bitel.bgbilling.modules.inet.runtime.CheckReentrantLock.lock(CheckReentrantLock.java:50)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.updateConnectionIpAddress(InetRadiusProcessor.java:757)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.connectionCallStart(InetRadiusProcessor.java:1262)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:1108)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:832)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:296)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accounting(RadiusProcessor.java:508)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accountingRequest(RadiusProcessor.java:445)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:136)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.processPacket(RadiusListenerWorker.java:202)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.runImpl(RadiusListenerWorker.java:88)
        at ru.bitel.common.worker.WorkerTask.run(WorkerTask.java:86)
        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)
accounting 03-05/11:03:44  WARN [accwrkr-3-p-10-t-1] CheckReentrantLock - Lock wait timeout (waiting next 15s)
...

accounting 03-05/12:06:49 ERROR [Thread-11] Accounting - Lock wait timeout for ContractId: 1; servId: 11
        ppp:bg
        Options [1:01.03.2012-01.01.1970; ] TariffModuleTreeSet [8:01.09.2011-…; ]
        Device state: 1; optionSet:1
java.lang.RuntimeException: Lock wait timeout for ContractId: 1; servId: 11
        ppp:bg
        Options [1:01.03.2012-01.01.1970; ] TariffModuleTreeSet [8:01.09.2011-…; ]
        Device state: 1; optionSet:1
        at ru.bitel.bgbilling.modules.inet.runtime.CheckReentrantLock.lock(CheckReentrantLock.java:46)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.saveState(Accounting.java:721)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.stop(Accounting.java:309)
        at ru.bitel.bgbilling.kernel.application.server.Application$3.run(Application.java:187)
        at ru.bitel.common.bootstrap.Shutdown$2.run(Shutdown.java:25)
Caused by: java.lang.RuntimeException: OwnerThread: Thread[rdsLstnr-p-6-t-1,5,main]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:156)
        at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:1987)
        at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:399)
        at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:947)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
        at java.lang.Thread.run(Thread.java:662)
        at ru.bitel.common.worker.WorkerThread.run(WorkerThread.java:40)
Caused by: java.lang.RuntimeException: Trace: Thread[rdsLstnr-p-6-t-1,5,main]
        at java.lang.Thread.getStackTrace(Thread.java:1479)
        at ru.bitel.bgbilling.modules.inet.runtime.CheckReentrantLock.lock(CheckReentrantLock.java:50)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.updateConnectionIpAddress(InetRadiusProcessor.java:757)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.connectionCallStart(InetRadiusProcessor.java:1262)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:1108)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusProcessor.getNasConnection(InetRadiusProcessor.java:832)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:296)
        at ru.bitel.bgbilling.modules.inet.radius.InetNas.updateConnection(InetNas.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accounting(RadiusProcessor.java:508)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusProcessor.accountingRequest(RadiusProcessor.java:445)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:136)
        at ru.bitel.bgbilling.modules.inet.radius.InetRadiusListenerWorker.accountingRequest(InetRadiusListenerWorker.java:1)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.processPacket(RadiusListenerWorker.java:202)
        at ru.bitel.bgbilling.kernel.network.radius.RadiusListenerWorker.runImpl(RadiusListenerWorker.java:88)
        at ru.bitel.common.worker.WorkerTask.run(WorkerTask.java:86)
        at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
        ... 2 more
 03-05/12:06:49  INFO [Thread-11] EventProcessor - Shutdown EventProcessor...

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

  Клиент: вер. 5.2 сборка 926 от 05.03.2012 15:06:19
    os: Windows XP; java: Java HotSpot(TM) Client VM, v.1.6.0_29
    ВНИМАНИЕ: Необходимо обновить таймзоны
  Сервер: вер. 5.2 сборка 1082 от 05.03.2012 15:06:04
    os: Linux; java: Java HotSpot(TM) Client VM, v.1.6.0_29
    ВНИМАНИЕ: Необходимо обновить таймзоны

  bill вер. 5.2 сборка 240 от 05.03.2012 15:07:37
  card вер. 5.2 сборка 163 от 03.03.2012 13:09:25
  dialup вер. 5.2 сборка 310 от 05.03.2012 15:06:46
  email вер. 5.2 сборка 159 от 03.03.2012 13:09:33
  inet вер. 5.2 сборка 750 от 05.03.2012 15:06:39
  mps вер. 5.2 сборка 143 от 03.03.2012 13:09:48
  npay вер. 5.2 сборка 164 от 03.03.2012 13:09:52
  rentsoft вер. 5.2 сборка 34 от 03.03.2012 13:10:15
  reports вер. 5.2 сборка 167 от 03.03.2012 13:10:15
  rscm вер. 5.2 сборка 154 от 03.03.2012 13:10:15
  ru.bitel.bgbilling.plugins.crm вер. 5.2 сборка 173 от 03.03.2012 13:10:55
  ru.bitel.bgbilling.plugins.documents вер. 5.2 сборка 137 от 03.03.2012 13:10:56
  ru.bitel.bgbilling.plugins.helpdesk вер. 5.2 сборка 158 от 03.03.2012 13:10:56
  ru.bitel.bgbilling.plugins.organizer вер. 5.2 сборка 55 от 03.03.2012 13:10:56

accounting 03-05/10:58:29 ERROR [main] Accounting - ParseError at [row,col]:[1,2036]
Message: XML document structures must start and end within the same entity.
javax.xml.stream.XMLStreamException: ParseError at [row,col]:[1,2036]
Message: XML document structures must start and end within the same entity.
        at com.sun.org.apache.xerces.internal.impl.XMLStreamReaderImpl.next(XMLStreamReaderImpl.java:594)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.loadState(Accounting.java:798)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.startImpl(Accounting.java:284)
        at ru.bitel.bgbilling.modules.inet.accounting.Accounting.start(Accounting.java:210)
        at ru.bitel.bgbilling.kernel.application.server.Application.application(Application.java:239)
        at ru.bitel.bgbilling.kernel.application.server.Application.<init>(Application.java:154)
        at ru.bitel.bgbilling.kernel.application.server.Application.main(Application.java:742)
        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)
accounting 03-05/10:58:29  INFO [main] Application - Started Accounting@32498805

radius 03-05/11:03:11  WARN [rdsLstnr-p-6-t-1] InetRadiusProcessor - Creating NasConnection from accounting packet [statusType=3]
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] InetRadiusProcessor - Connection exist in db
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] InetRadiusProcessor - Session exist in db
radius 03-05/11:03:11  INFO [rdsLstnr-p-6-t-1] connection - 4162:4403 Register ip: 192.168.66.32
radius 03-05/11:03:11 ERROR [rdsLstnr-p-6-t-1] InetNas - InetNasConnection is null
radius 03-05/11:03:11 ERROR [rdsLstnr-p-6-t-1] RadiusListenerWorker -