Current-time: Dec 30 01:06:38 PST (UTC -0800) H323-conf-id: 429A957E 23C70170 368014DA 2025F6D4 SIP Call-ID: 91.121.122.64-1325235960.335 Requests: 5 REQUEST-- Dec 30 01:06:00: Processing request (BE ver1.245.2.11,pid20219): NAS-IP-Address = '91.121.122.64' NAS-Port-Name = 'SIP/412X55XXXXX-0000014f' User-Name = '412X55XXXXX' Called-Station-Id = '4178ABCDEFGH' Calling-Station-Id = '412X55XXXXX' h323-conf-id = '429A957E 23C70170 368014DA 2025F6D4' call-id = '91.121.122.64-1325235960.335' Digest-Attributes = 'User-Name = "412X55XXXXX"' Digest-Attributes = 'Realm = "switzernet"' Digest-Attributes = 'Nonce = "75877be1"' Digest-Attributes = 'URI = "sip:4178ABCDEFGH@astrad.switzernet.com"' Digest-Attributes = 'Method = "INVITE"' Digest-Attributes = 'Algorithm = "MD5"' Digest-Response = 'cdbc0a7e37e7e05cc87c54ebcfc5feda' h323-remote-address = '212.147.8.99' h323-ivr-out = 'PortaBilling_Routing:SIP' h323-session-protocol = 'sipv2' h323-ivr-out = 'PortaBilling_AuthMethod:INVITE' Dec 30 01:06:00: h323-conf-id=429A957E 23C70170 368014DA 2025F6D4/1, call-id=91.121.122.64-1325235960.335/1 Dec 30 01:06:00: H323/SIP call, use h323-conf-id, but remember call-id Dec 30 01:06:00: Checking if this call comes through a VoIP from vendor connection Dec 30 01:06:00: No VoIP from vendor connections were found Dec 30 01:06:00: PrepareNexecute 'AccountAuth' Dec 30 01:06:00: SQL query 'AccountAuth' executed in 0.001788 seconds Dec 30 01:06:00: Found Account: 412X55XXXXX[71344,credit,balance=0.22000,limit=none] of customer Swiss office test[30815,balance=0.22000,limit=11.00000] Dec 30 01:06:00: PrepareNexecute 'GetSessions' Dec 30 01:06:00: SQL query 'GetSessions' executed in 0.001139 seconds Dec 30 01:06:00: Account 412X55XXXXX is not logged in yet Dec 30 01:06:00: Verification of password using method 'digest_response': success Dec 30 01:06:00: PrepareNexecute 'GetAttributeValues' Dec 30 01:06:00: SQL query 'GetAttributeValues' executed in 0.014144 seconds Dec 30 01:06:00: PrepareNexecute 'GetCustomerActiveCalls' Dec 30 01:06:00: SQL query 'GetCustomerActiveCalls' executed in 0.001707 seconds Dec 30 01:06:00: PrepareNexecute 'GetAttributeValues' Dec 30 01:06:00: SQL query 'GetAttributeValues' executed in 0.010283 seconds Dec 30 01:06:00: Applying 'clir' service check translation rule on CLD ... Dec 30 01:06:00: Translation 's/^\*81/Y/; # hide=*81' applied: '4178ABCDEFGH' unchanged Dec 30 01:06:00: Applying customer dialing translation rule on CLD ... Dec 30 01:06:00: Translation 'local_to_e164($_,{cc=>'41',dp=>'0',ip=>'00'});#% cc=41 dp=0 ip=00' applied: '4178ABCDEFGH' unchanged Dec 30 01:06:00: Applying node translation rule on CLD ... Dec 30 01:06:00: Translation 's/^000//; s/^0//; s/^011//; s/^9950011//; s/^99501/1/; s/^3450011//; s/^3950011//; s/^3542011//;' applied: '4178ABCDEFGH' unchanged Dec 30 01:06:00: PrepareNexecute 'AccountAuth' Dec 30 01:06:00: SQL query 'AccountAuth' executed in 0.001847 seconds Dec 30 01:06:00: CLD '4178ABCDEFGH' is an off-net number Dec 30 01:06:00: Setting up a new charge with tariff 'private' ... Dec 30 01:06:00: Using peak rate, since no off-peak is defined Dec 30 01:06:00: PrepareNexecute 'GetPricePerDestination*' Dec 30 01:06:00: SQL query 'GetPricePerDestination*' executed in 0.002174 seconds Dec 30 01:06:00: Compute maximum call duration for leg Account 412X55XXXXX to destination with funds 10.78 (customer funds 10.78) Dec 30 01:06:00: Maximum call duration: 5880 announced as 5880 (+1x1x0.11+5879x1x0.11) by rate 10560089 using 55847 as seed Dec 30 01:06:00: Applying 'clir' service check translation rule on CLD ... Dec 30 01:06:00: Translation 's/^\*81/Y/; # hide=*81' applied: '4178ABCDEFGH' unchanged Dec 30 01:06:00: Remote termination 'PortaSIP': Calculating routing for 4178ABCDEFGH Dec 30 01:06:00: RTP Proxy with origination preference 'Undetermined', Calling party NOT behind NAT. Dec 30 01:06:00: Looking up routes to '4178ABCDEFGH' using '' routing plan Dec 30 01:06:00: PrepareNexecute 'GetRoutingPerDestination*' Dec 30 01:06:00: SQL query 'GetRoutingPerDestination*' executed in 0.006023 seconds Dec 30 01:06:00: Checked 2011-12-30 10:06:00 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:00: Start of call is peak level 0 Dec 30 01:06:00: Using peak rate, since no off-peak is defined Dec 30 01:06:00: Checked 2011-12-30 10:06:00 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:00: Start of call is peak level 0 Dec 30 01:06:00: Checked 2011-12-30 10:06:00 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:00: Start of call is peak level 0 Dec 30 01:06:00: Checked 2011-12-30 10:06:00 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:00: Start of call is peak level 0 Dec 30 01:06:00: Applying route outgoing CLD translation on '4178ABCDEFGH' ... Dec 30 01:06:00: Translation 's/^(\d)/\+$1/;' applied: '4178ABCDEFGH' -> '+4178ABCDEFGH' Dec 30 01:06:00: Applying route outgoing CLD translation on '4178ABCDEFGH' ... Dec 30 01:06:00: Translation 's/^(\d)/00$1/;' applied: '4178ABCDEFGH' -> '004178ABCDEFGH' Dec 30 01:06:00: Applying route outgoing CLD translation on '4178ABCDEFGH' ... Dec 30 01:06:00: Translation 's/^(\d)/\+$1/;' applied: '4178ABCDEFGH' -> '+4178ABCDEFGH' Dec 30 01:06:00: Applying route outgoing CLD translation on '4178ABCDEFGH' ... Dec 30 01:06:00: Translation 's/^(\d)/00$1/;' applied: '4178ABCDEFGH' -> '004178ABCDEFGH' Dec 30 01:06:00: Applying route outgoing CLI translation on '412X55XXXXX' ... Dec 30 01:06:00: Translation 's/^(\d)/\+$1/;' applied: '412X55XXXXX' -> '+412X55XXXXX' Dec 30 01:06:00: Applying route outgoing CLI translation on '412X55XXXXX' ... Dec 30 01:06:00: Translation 's/^(\d)/00$1/;' applied: '412X55XXXXX' -> '00412X55XXXXX' Dec 30 01:06:00: Applying route outgoing CLI translation on '412X55XXXXX' ... Dec 30 01:06:00: Translation 's/^(\d)/\+$1/;' applied: '412X55XXXXX' -> '+412X55XXXXX' Dec 30 01:06:00: Applying route outgoing CLI translation on '412X55XXXXX' ... Dec 30 01:06:00: Translation 's/^(\d)/00$1/;' applied: '412X55XXXXX' -> '00412X55XXXXX' Dec 30 01:06:00: Result routes to destination '4178ABCDEFGH': +4178ABCDEFGH@212.249.15.4, prio = 5, cost = 0.13772, 'OpenSER 3' - to remote GW 004178ABCDEFGH@212.249.15.5, prio = 5, cost = 0.13772, 'AstSS7 Swi' - to remote GW +4178ABCDEFGH@212.249.15.9, prio = 5, cost = 0.13772, 'OpenSER 9' - to remote GW 004178ABCDEFGH@217.168.45.4, prio = 5, cost = 0.14664, 'Asterisk SS7' - to remote GW 4178ABCDEFGH@80.77.12.195, prio = 4, cost = 0.17930, 'reliance UK' - to remote GW Dec 30 01:06:00: Logging in account '412X55XXXXX'(71344) to '429A957E 23C70170 368014DA 2025F6D4' Dec 30 01:06:00: PrepareNexecute 'AddSession' Dec 30 01:06:00: SQL query 'AddSession' executed in 0.001541 seconds Dec 30 01:06:00: Authentication acknowledge response h323-ivr-in = PortaBilling_Routing:@;g-hunt=seq h323-ivr-in = PortaBilling_Routing: @;g-hunt=skip;expires=300;credit-time=5880;patience=20 h323-ivr-in = PortaBilling_Routing: +4178ABCDEFGH@212.249.15.4;cli=+412X55XXXXX h323-ivr-in = PortaBilling_Routing: 004178ABCDEFGH@212.249.15.5;cli=00412X55XXXXX h323-ivr-in = PortaBilling_Routing: +4178ABCDEFGH@212.249.15.9;cli=+412X55XXXXX h323-ivr-in = PortaBilling_Routing: 004178ABCDEFGH@217.168.45.4;cli=00412X55XXXXX;rtpp=1 h323-ivr-in = PortaBilling_Routing: 4178ABCDEFGH@80.77.12.195 h323-billing-model = 0 h323-ivr-in = Tariff:private h323-ivr-in = PortaBilling_CLI:412X55XXXXX h323-ivr-in = MOH:1 h323-ivr-in = PortaBilling_CompleteNumber:4178ABCDEFGH h323-ivr-in = PortaBilling_Auth_CLD:4178ABCDEFGH h323-ivr-in = PortaBilling_Auth_Reseller_CLD:4178ABCDEFGH h323-ivr-in = DURATION:5880 h323-return-code = 0 h323-currency = CHF h323-credit-time = 5880 h323-preferred-lang = fr Dec 30 01:06:00: ...Done Authorize/INVITE in 0.073113 seconds, 0.040646 spent in SQL queries. --REQUEST REQUEST-- Dec 30 01:06:04: Processing request (BE ver1.245.2.11,pid20219): NAS-IP-Address = '91.121.122.64' User-Name = '412X55XXXXX' Called-Station-Id = '4178ABCDEFGH' <= different Calling-Station-Id = '412X55XXXXX' Acct-Status-Type = 'Start' h323-call-origin = 'originate' h323-call-type = 'VoIP' h323-setup-time = '09:06:00 GMT Fri Dec 30 2011' h323-connect-time = '09:06:04 GMT Fri Dec 30 2011' h323-conf-id = '429A957E 23C70170 368014DA 2025F6D4' call-id = '91.121.122.64-1325235960.335' Acct-Session-Id = '91.121.122.64-1325235960.335' Acct-Delay-Time = '0' h323-session-protocol = 'sipv2' NAS-Port = '5060' h323-ivr-out = 'PortaBilling_Auth_CLD:4178ABCDEFGH' h323-ivr-out = 'DURATION:5880' h323-remote-address = '212.249.15.4' Exec-Program-Log = 'porta-billing.pl' Dec 30 01:06:04: h323-conf-id=429A957E 23C70170 368014DA 2025F6D4/1, call-id=91.121.122.64-1325235960.335/1 Dec 30 01:06:04: Found a call in cache with such id Dec 30 01:06:04: Copied account: 412X55XXXXX[71344,credit,balance=0.22000,limit=none] of customer Swiss office test[30815,balance=0.22000,limit=11.00000] from '91.121.122.64' into the current request Dec 30 01:06:04: Fixing time with duration 0 seconds from connect time Dec 30 01:06:04: PrepareNexecute 'GetActiveLegIdByAcct' Dec 30 01:06:04: SQL query 'GetActiveLegIdByAcct' executed in 0.000964 seconds Dec 30 01:06:04: Looking up vendor/connection Dec 30 01:06:04: Trying to match connection for call Dec 30 01:06:04: Looking for a connection VoIP/originate Dec 30 01:06:04: Outgoing VoIP, matching by the remote IP address '212.249.15.4' (env 1) Dec 30 01:06:04: Found connection 205 'OpenSER 3' to vendor 'Verizon' Dec 30 01:06:04: Found vendor/connection Dec 30 01:06:04: PrepareNexecute 'InsertActiveLeg' Dec 30 01:06:04: SQL query 'InsertActiveLeg' executed in 0.001371 seconds Dec 30 01:06:04: Accounting response Dec 30 01:06:04: ...Done Accounting/Start/originate/VoIP in 0.009570 seconds, 0.002335 spent in SQL queries. --REQUEST REQUEST-- Dec 30 01:06:08: Processing request (BE ver1.245.2.11,pid20219): NAS-IP-Address = '91.121.122.64' User-Name = '412X55XXXXX' Called-Station-Id = '4178ABCDEFGH' Calling-Station-Id = '412X55XXXXX' Acct-Status-Type = 'Start' h323-call-origin = 'answer' h323-call-type = 'VoIP' h323-setup-time = '09:06:00 GMT Fri Dec 30 2011' h323-connect-time = '09:06:08 GMT Fri Dec 30 2011' h323-conf-id = '429A957E 23C70170 368014DA 2025F6D4' call-id = '91.121.122.64-1325235960.335' Acct-Session-Id = '91.121.122.64-1325235960.335' Acct-Delay-Time = '0' h323-session-protocol = 'sipv2' NAS-Port = '5060' alert-timepoint = '09:06:08 GMT Fri Dec 30 2011' h323-remote-address = '212.147.8.99' Exec-Program-Log = 'porta-billing.pl' Dec 30 01:06:08: h323-conf-id=429A957E 23C70170 368014DA 2025F6D4/1, call-id=91.121.122.64-1325235960.335/1 Dec 30 01:06:08: Found a call in cache with such id Dec 30 01:06:08: Copied account: 412X55XXXXX[71344,credit,balance=0.22000,limit=none] of customer Swiss office test[30815,balance=0.22000,limit=11.00000] from '91.121.122.64' into the current request Dec 30 01:06:08: Fixing time with duration 0 seconds from connect time Dec 30 01:06:08: PrepareNexecute 'GetActiveLegIdByAcct' Dec 30 01:06:08: SQL query 'GetActiveLegIdByAcct' executed in 0.000978 seconds Dec 30 01:06:08: Looking up vendor/connection Dec 30 01:06:08: Trying to match connection for call Dec 30 01:06:08: Looking for a connection VoIP/answer Dec 30 01:06:08: VoIP, matching by the node IP '91.121.122.64' and User-Name '412X55XXXXX' Dec 30 01:06:08: No VoIP from vendor connections were found Dec 30 01:06:08: Connection to vendor not found Dec 30 01:06:08: PrepareNexecute 'InsertActiveLeg' Dec 30 01:06:08: SQL query 'InsertActiveLeg' executed in 0.001506 seconds Dec 30 01:06:08: Accounting response Dec 30 01:06:08: ...Done Accounting/Start/answer/VoIP in 0.008357 seconds, 0.002484 spent in SQL queries. --REQUEST REQUEST-- Dec 30 01:06:15: Processing request (BE ver1.245.2.11,pid20219): NAS-IP-Address = '91.121.122.64' User-Name = '412X55XXXXX' Called-Station-Id = '4178ABCDEFGH' Calling-Station-Id = '412X55XXXXX' Acct-Status-Type = 'Stop' h323-call-origin = 'answer' h323-call-type = 'VoIP' h323-setup-time = '09:06:00 GMT Fri Dec 30 2011' h323-connect-time = '09:06:08 GMT Fri Dec 30 2011' h323-disconnect-time = '09:06:15 GMT Fri Dec 30 2011' h323-disconnect-cause = '10' h323-conf-id = '429A957E 23C70170 368014DA 2025F6D4' call-id = '91.121.122.64-1325235960.335' Acct-Session-Id = '91.121.122.64-1325235960.335' Acct-Session-Time = '7' Acct-Delay-Time = '0' h323-session-protocol = 'sipv2' NAS-Port = '5060' h323-ivr-out = 'PortaBilling_Session:unlock' h323-remote-address = '212.147.8.99' alert-timepoint = '09:06:08 GMT Fri Dec 30 2011' Exec-Program-Log = 'porta-billing.pl' Dec 30 01:06:15: h323-conf-id=429A957E 23C70170 368014DA 2025F6D4/1, call-id=91.121.122.64-1325235960.335/1 Dec 30 01:06:15: Found a call in cache with such id Dec 30 01:06:15: Copied account: 412X55XXXXX[71344,credit,balance=0.22000,limit=none] of customer Swiss office test[30815,balance=0.22000,limit=11.00000] from '91.121.122.64' into the current request Dec 30 01:06:15: PrepareNexecute 'GetActiveLegIdByAcct' Dec 30 01:06:15: SQL query 'GetActiveLegIdByAcct' executed in 0.219069 seconds Dec 30 01:06:15: PrepareNexecute 'DeleteActiveLeg' Dec 30 01:06:15: SQL query 'DeleteActiveLeg' executed in 0.00155 seconds Dec 30 01:06:15: Force unlock requested by NAS Dec 30 01:06:15: Scheduling 412X55XXXXX for logout, call lifetime reduced to 15 Dec 30 01:06:15: PrepareNexecute 'GetSessions' Dec 30 01:06:15: SQL query 'GetSessions' executed in 0.000553 seconds Dec 30 01:06:15: Logging out account '412X55XXXXX'(71344) from '429A957E 23C70170 368014DA 2025F6D4' Dec 30 01:06:15: PrepareNexecute 'RemoveSession' Dec 30 01:06:15: SQL query 'RemoveSession' executed in 0.001967 seconds Dec 30 01:06:15: Set lifetime with 15s to Fri Dec 30 01:06:30 2011 Dec 30 01:06:15: Looking up vendor/connection Dec 30 01:06:15: Trying to match connection for call Dec 30 01:06:15: Looking for a connection VoIP/answer Dec 30 01:06:15: VoIP, matching by the node IP '91.121.122.64' and User-Name '412X55XXXXX' Dec 30 01:06:15: No VoIP from vendor connections were found Dec 30 01:06:15: Connection to vendor not found Dec 30 01:06:15: No connection from vendor Dec 30 01:06:15: Accounting response Dec 30 01:06:15: ...Done Accounting/Stop/answer/VoIP in 0.230857 seconds, 0.223139 spent in SQL queries. --REQUEST REQUEST-- Dec 30 01:06:15: Processing request (BE ver1.245.2.11,pid20219): NAS-IP-Address = '91.121.122.64' User-Name = '412X55XXXXX' Called-Station-Id = '4178ABCDEFGH' <= Different Calling-Station-Id = '412X55XXXXX' Acct-Status-Type = 'Stop' h323-call-origin = 'originate' h323-call-type = 'VoIP' h323-setup-time = '09:06:00 GMT Fri Dec 30 2011' h323-connect-time = '09:06:04 GMT Fri Dec 30 2011' h323-disconnect-time = '09:06:15 GMT Fri Dec 30 2011' h323-disconnect-cause = '10' h323-conf-id = '429A957E 23C70170 368014DA 2025F6D4' call-id = '91.121.122.64-1325235960.335' Acct-Session-Id = '91.121.122.64-1325235960.335' Acct-Session-Time = '7' Acct-Delay-Time = '0' h323-session-protocol = 'sipv2' NAS-Port = '5060' h323-ivr-out = 'PortaBilling_Auth_CLD:4178ABCDEFGH' h323-ivr-out = 'DURATION:5880' h323-remote-address = '212.249.15.4' Exec-Program-Log = 'porta-billing.pl' Dec 30 01:06:15: h323-conf-id=429A957E 23C70170 368014DA 2025F6D4/1, call-id=91.121.122.64-1325235960.335/1 Dec 30 01:06:15: Found a call in cache with such id Dec 30 01:06:15: Copied account: 412X55XXXXX[71344,credit,balance=0.22000,limit=none] of customer Swiss office test[30815,balance=0.22000,limit=11.00000] from '91.121.122.64' into the current request Dec 30 01:06:15: PrepareNexecute 'GetActiveLegIdByAcct' Dec 30 01:06:15: SQL query 'GetActiveLegIdByAcct' executed in 0.001729 seconds Dec 30 01:06:15: PrepareNexecute 'DeleteActiveLeg' Dec 30 01:06:15: SQL query 'DeleteActiveLeg' executed in 0.001694 seconds Dec 30 01:06:15: End of the outgoing call for logged in account. Waiting another outgoing call or hang up Dec 30 01:06:15: Set lifetime with 15s to Fri Dec 30 01:06:30 2011 Dec 30 01:06:15: Looking up vendor/connection Dec 30 01:06:15: Trying to match connection for call Dec 30 01:06:15: Looking for a connection VoIP/originate Dec 30 01:06:15: Outgoing VoIP, matching by the remote IP address '212.249.15.4' (env 1) Dec 30 01:06:15: Found connection 205 'OpenSER 3' to vendor 'Verizon' Dec 30 01:06:15: Found vendor/connection Dec 30 01:06:15: Applying connection translation rule on CLD ... Dec 30 01:06:15: Translation 's/^\+//;' applied: '4178ABCDEFGH' unchanged Dec 30 01:06:15: Charging call ... Dec 30 01:06:15: Using peak rate, since no off-peak is defined Dec 30 01:06:15: Can reuse the already initialized charge. Dec 30 01:06:15: Calculating account's charge by tariff 'private' Dec 30 01:06:15: Call to '4178ABCDEFGH' with duration 11 seconds will be charged for 11 seconds and cost is 0.03 (1x1x0.11+10x1x0.11^2) by rate 10560089 using 55847 as seed Dec 30 01:06:15: Setting up a new charge with tariff 'verizon-PRE' ... Dec 30 01:06:15: Checked 2011-12-30 10:06:04 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:15: Checked 2011-12-30 10:06:15 Europe/Zurich against 'hr{17-7} wd{mo-fr }, wd{sa su }, md{25} mo{dec}, md{26} mo{dec}, md{1} mo{jan}, md{2} mo{jan}, md{10} mo{apr}, md{13} mo{apr}, md{1} mo{may}, md{1} mo{jun}, md{1} mo{aug}': 0 Dec 30 01:06:15: Start of call is peak level 0 Dec 30 01:06:15: End of call is peak level 0 Dec 30 01:06:15: PrepareNexecute 'GetPricePerDestination*' Dec 30 01:06:15: SQL query 'GetPricePerDestination*' executed in 0.001715 seconds Dec 30 01:06:15: Calculating vendor's charge by tariff 'verizon-PRE' Dec 30 01:06:15: Call to '4178ABCDEFGH' with duration 11 seconds will be charged for 11 seconds and cost is 0.02067 (1x1x0.1127+10x1x0.1127) by rate 7430175 using 55847 as seed Dec 30 01:06:15: Charging account for the call Dec 30 01:06:15: Inserting CDR Dec 30 01:06:15: PrepareNexecute 'InsertAccountCDR' Dec 30 01:06:15: SQL query 'InsertAccountCDR' executed in 0.001453 seconds Dec 30 01:06:15: Charging credit account 412X55XXXXX 0.03 Dec 30 01:06:15: PrepareNexecute 'UpdateAccountBalance' Dec 30 01:06:15: SQL query 'UpdateAccountBalance' executed in 0.001746 seconds Dec 30 01:06:15: Charging account's owner for the call Dec 30 01:06:15: Charging customer 30815 'Swiss office test' 0.03 Dec 30 01:06:15: PrepareNexecute 'UpdateCustomerBalance' Dec 30 01:06:15: SQL query 'UpdateCustomerBalance' executed in 0.000974 seconds Dec 30 01:06:15: Charging vendor for the call Dec 30 01:06:15: Charging vendor 55 'Verizon' 0.02067 Dec 30 01:06:15: Inserting CDR Dec 30 01:06:15: PrepareNexecute 'InsertVendorCDR' Dec 30 01:06:15: SQL query 'InsertVendorCDR' executed in 0.001168 seconds Dec 30 01:06:15: PrepareNexecute 'UpdateVendorBalance' Dec 30 01:06:15: SQL query 'UpdateVendorBalance' executed in 0.001319 seconds Dec 30 01:06:15: Accounting response Dec 30 01:06:15: ...Done Accounting/Stop/originate/VoIP in 0.029487 seconds, 0.011798 spent in SQL queries. --REQUEST