[Asterisk-Users] a2billing problem with call duration
d_pejic at inecco.net
d_pejic at inecco.net
Tue Mar 7 07:32:25 MST 2006
Regards!
During the use of areski a2billing software I'm getting same problem all the time.
Actually, after 15 minutes of speaking to someone over calling card, connection brakes.
Installation was as smooth as it could be so I don't think I made same kind of a mess in that domain. This is the only problem in the aplication.
In the logs everything seems to be fine.
I'am sending You log as an apendix bellow the text.
Is it a asterisk problem or...
a2billing.log
[05/03/2006 19:39:45]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:39:45]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:39:45]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_rate-engine: number_trunk 1]
[05/03/2006 19:39:46]:[CallerID:051359687]:[CN:0474]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT (81.1667)]
[05/03/2006 19:39:46]:[CallerID:051359687]:[CN:0474]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT: k=0 - res_calcultimeout:4869]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:DIAL SIP/odlazni/00436642780018|90|HL(4869000:61000:30000)
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[K=0]:[ANSWEREDTIME=751-DIALSTATUS=ANSWER]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[USEDRATECARD=0]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_RATE_ENGINE_CALCULCOST: K=0 - CALLDURATION:751]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[TEMP - CC_RATE_ENGINE_CALCULCOST: 1. COST: -12.516666666667]:[ (751/60) * 1 ]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_RATE_ENGINE_CALCULCOST: K=0 - FINAL COST: -12.516666666667]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_RATE_ENGINE_UPDATESYSTEM: usedratecard K=0 - (sessiontime=751 :: dialstatus=ANSWER :: cost=12.516666666667)]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_stop 1.1: SQL: INSERT INTO call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src) VALUES ('1141583953.47', 'SIP/callingcard-50e8', '0474', '', CURRENT_TIMESTAMP - INTERVAL 751 SECOND , '751', '00436642780018', 'ANSWER', now(), '1', '12.516666666667', '', '', 'svet', '1', '1', '1', '1', '051359687' )]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_stop 1.1: SQL: DONE]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-12.516666666667, redial='00436642780018', lastuse=now(), nbused=nbused+1 WHERE username='0474']
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[callingcard_acct_stop]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CHANNEL STATUS : 6 = Line is up]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CREDIT STATUS : 68.650033333333]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[DTMF DESTINATION ::> -1]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CHANNEL STATUS : -1 = There is no channel that matches SIP/callingcard-50e8]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[CREDIT STATUS : 68.650033333333]
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[Start: UPDATE cc_card SET inuse=inuse-1 WHERE username='0474']
[05/03/2006 19:52:37]:[CallerID:051359687]:[CN:0474]:[STOP - EXIT]
[05/03/2006 19:38:06]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:38:06]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:38:06]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: number_trunk 1]
[05/03/2006 19:38:06]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT (46.750033333333)]
[05/03/2006 19:38:06]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT: k=0 - res_calcultimeout:2804]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:DIAL SIP/odlazni/00497720954992|90|HL(2804000:61000:30000)
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[K=0]:[ANSWEREDTIME=937-DIALSTATUS=ANSWER] ( my max call duration 937 sec)
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[USEDRATECARD=0]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_CALCULCOST: K=0 - CALLDURATION:937]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[TEMP - CC_RATE_ENGINE_CALCULCOST: 1. COST: -15.616666666667]:[ (937/60) * 1 ]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_CALCULCOST: K=0 - FINAL COST: -15.616666666667]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_UPDATESYSTEM: usedratecard K=0 - (sessiontime=937 :: dialstatus=ANSWER :: cost=15.616666666667)]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.1: SQL: INSERT INTO call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src) VALUES ('2141583490.41', 'SIP/callingcard-31f3', '4513', '', CURRENT_TIMESTAMP - INTERVAL 937 SECOND , '937', '00497720954992', 'ANSWER', now(), '1', '15.616666666667', '', '', 'svet', '1', '1', '1', '1', '051212072' )]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.1: SQL: DONE][05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-15.616666666667, redial='00497720954992', lastuse=now(), nbused=nbused+1 WHERE username='4513']
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[callingcard_acct_stop]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CHANNEL STATUS : 6 = Line is up][05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[CREDIT STATUS : 31.133366666667]
[05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[DTMF DESTINATION ::> -1][05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[Start: UPDATE cc_card SET inuse=inuse-1 WHERE username='4513'][05/03/2006 19:53:58]:[CallerID:051212072]:[CN:4513]:[exit][05/03/2006 19:54:21]:[CallerID:051212072]:[CN:]:EXEC SETLANGUAGE en
[05/03/2006 19:54:21]:[CallerID:051212072]:[CN:]:[CID_ENABLE - CID_CONTROL - CID:051212072]
[05/03/2006 19:54:21]:[CallerID:051212072]:[CN:]:[CID_CONTROL - STOP - NO CALLERID][05/03/2006 19:54:34]:[CallerID:051212072]:[CN:4513]:[TRY : callingcard_ivr_authenticate]
[05/03/2006 19:54:34]:[CallerID:051212072]:[CN:4513]:[callingcard_acct_start_inuse]
[05/03/2006 19:54:34]:[CallerID:051212072]:[CN:4513]:[Start: UPDATE cc_card SET inuse=inuse+1 WHERE username='4513']
[05/03/2006 19:54:34]:[CallerID:051212072]:[CN:4513]:[CHANNEL STATUS : 6 = Line is up]
[05/03/2006 19:54:34]:[CallerID:051212072]:[CN:4513]:[CREDIT STATUS : 31.1333]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[DTMF DESTINATION ::> 00497720954992]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: (1, 00497720954992)]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: SUPER QUERY]
SELECT tariffgroupname, lcrtype, idtariffgroup, cc_tariffgroup_plan.idtariffplan, tariffname, destination,
cc_ratecard.id,
dialprefix, destination, buyrate, buyrateinitblock, buyrateincrement, rateinitial, initblock, billingblock,
connectcharge, disconnectcharge, stepchargea, chargea, timechargea, billingblocka, stepchargeb, chargeb,
timechargeb, billingblockb, stepchargec, chargec, timechargec, billingblockc,
cc_tariffplan.id_trunk AS tp_id_trunk, tp_trunk.trunkprefix AS tp_trunk, tp_trunk.providertech AS tp_providertech,
tp_trunk.providerip AS tp_providerip, tp_trunk.removeprefix AS tp_removeprefix,
cc_ratecard.id_trunk AS rc_id_trunk, rt_trunk.trunkprefix AS rc_trunkprefix, rt_trunk.providertech AS rc_providertech,
rt_trunk.providerip AS rc_providerip, rt_trunk.removeprefix AS rc_removeprefix,
musiconhold, tp_trunk.failover_trunk AS tp_failover_trunk,
rt_trunk.failover_trunk AS rt_failover_trunk,
tp_trunk.addparameter AS tp_addparameter_trunk, rt_trunk.addparameter AS rt_addparameter_trunk
FROM cc_tariffgroup
RIGHT JOIN cc_tariffgroup_plan ON cc_tariffgroup.id=1
INNER JOIN cc_tariffplan ON (cc_tariffplan.id=cc_tariffgroup_plan.idtariffplan )
LEFT JOIN cc_ratecard ON cc_ratecard.idtariffplan=cc_tariffplan.id
LEFT JOIN trunk AS rt_trunk ON cc_ratecard.id_trunk=rt_trunk.id_trunk
LEFT JOIN trunk AS tp_trunk ON cc_tariffplan.id_trunk=tp_trunk.id_trunk
WHERE (dialprefix=SUBSTRING('00497720954992',1,length(dialprefix)) OR dialprefix='defaultprefix')
AND startingdate<= CURRENT_TIMESTAMP AND (expirationdate > CURRENT_TIMESTAMP OR expirationdate IS NULL OR LENGTH(expirationdate)<5)
AND startdate<= CURRENT_TIMESTAMP AND (stopdate > CURRENT_TIMESTAMP OR stopdate IS NULL OR LENGTH(stopdate)<5)
AND sunday='1'
AND idtariffgroup='1'
AND ( cc_tariffplan.dnidprefix LIKE '192.168.0.36%' OR (cc_tariffplan.dnidprefix='all' AND 0 = 0))
ORDER BY LENGTH(dialprefix) DESC
[05/03/2006 19:55:25]:[CallerID:051379680]:[CN:]:EXEC SETLANGUAGE en
[05/03/2006 19:55:25]:[CallerID:051379680]:[CN:]:[CID_ENABLE - CID_CONTROL - CID:051379680]
[05/03/2006 19:55:25]:[CallerID:051379680]:[CN:]:[CID_CONTROL - STOP - NO CALLERID]
[05/03/2006 19:55:43]:[CallerID:051379680]:[CN:4963]:[TRY : callingcard_ivr_authenticate]
[05/03/2006 19:55:43]:[CallerID:051379680]:[CN:4963]:[AUTHENTICATION FAILED (cia_res:-1)]
[05/03/2006 19:55:44]:[CallerID:051379680]:[CN:4963]:[exit]
[05/03/2006 19:55:57]:[CallerID:051379680]:[CN:]:EXEC SETLANGUAGE en
[05/03/2006 19:55:57]:[CallerID:051379680]:[CN:]:[CID_ENABLE - CID_CONTROL - CID:051379680]
[05/03/2006 19:55:57]:[CallerID:051379680]:[CN:]:[CID_CONTROL - STOP - NO CALLERID]
[05/03/2006 19:56:12]:[CallerID:051379680]:[CN:-1]:[TRY : callingcard_ivr_authenticate]
[05/03/2006 19:56:12]:[CallerID:051379680]:[CN:-1]:[AUTHENTICATION FAILED (cia_res:-1)]
[05/03/2006 19:56:12]:[CallerID:051379680]:[CN:-1]:[exit]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: Count Total result 1]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_rate-engine: number_trunk 1]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT (31.1333)]
[05/03/2006 19:54:50]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_ALL_CALCULTIMEOUT: k=0 - res_calcultimeout:1866]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:DIAL SIP/odlazni/00497720954992|90|HL(1866000:61000:30000)
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[K=0]:[ANSWEREDTIME=903-DIALSTATUS=ANSWER]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[USEDRATECARD=0]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_CALCULCOST: K=0 - CALLDURATION:903]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[TEMP - CC_RATE_ENGINE_CALCULCOST: 1. COST: -15.05]:[ (903/60) * 1 ]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_CALCULCOST: K=0 - FINAL COST: -15.05][05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_RATE_ENGINE_UPDATESYSTEM: usedratecard K=0 - (sessiontime=903 :: dialstatus=ANSWER :: cost=15.05)][05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.1: SQL: INSERT INTO call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src) VALUES ('1141584857.49', 'SIP/callingcard-716f', '4513', '', CURRENT_TIMESTAMP - INTERVAL 903 SECOND , '903', '00497720954992', 'ANSWER', now(), '1', '15.05', '', '', 'svet', '1', '1', '1', '1', '051212072' )]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.1: SQL: DONE][05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-15.05, redial='00497720954992', lastuse=now(), nbused=nbused+1 WHERE username='4513']
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[callingcard_acct_stop]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CHANNEL STATUS : 6 = Line is up]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CREDIT STATUS : 16.0833]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[DTMF DESTINATION ::> -1]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CHANNEL STATUS : -1 = There is no channel that matches SIP/callingcard-716f]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[CREDIT STATUS : 16.0833]
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[Start: UPDATE cc_card SET inuse=inuse-1 WHERE username='4513']
[05/03/2006 20:10:07]:[CallerID:051212072]:[CN:4513]:[STOP - EXIT]
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20060307/222ad916/attachment.htm
More information about the asterisk-users
mailing list