asterisk2billing.org http://forum.asterisk2billing.org/ |
|
CALLBACK-ALL Billing Problem http://forum.asterisk2billing.org/viewtopic.php?f=16&t=2871 |
Page 1 of 2 |
Author: | globaphone [ Fri Nov 30, 2007 5:22 pm ] |
Post subject: | CALLBACK-ALL Billing Problem |
Hi I did install the Callback successfully and I made few calls for testing, it works , I made calls, the problem is when I initiate a callback and i get connected to my callee: if I am the first one who hang up the call , the callback to me is billed but not the second leg, if the Person I called hang up first the call is billed for both legs without any problem. I am using Freepbx 2.3.1.0 with asterisk 1.4 , the A2billing is version is the Asterisk2Billing - Version 1.3.1 (Yellowjacket) - Release : September 2007 that s what i can see on the screen. for the successful billing [Nov 30 11:33:25] VERBOSE[6430] logger.c: -- Executing [1519821@inbound:1] NoOp("SIP/1519821-0884b588", "Incoming call from # 0015147879423") in new stack [Nov 30 11:33:25] VERBOSE[6430] logger.c: -- Executing [1519821@inbound:2] Ringing("SIP/1519821-0884b588", "") in new stack [Nov 30 11:33:25] VERBOSE[6430] logger.c: -- Executing [1519821@inbound:3] DeadAGI("SIP/1519821-0884b588", "a2billing.php|3|all-callback") in new stack [Nov 30 11:33:25] WARNING[6430] res_agi.c: Running DeadAGI on a live channel will cause problems, please use AGI [Nov 30 11:33:25] VERBOSE[6430] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: A2Billing AGI internal configuration: [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: Array [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [debug] => 3 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [asterisk_version] => 1_4 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [answer_call] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [number_try] => 1 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [sip_iax_friends] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [jump_voucher_if_min_credit] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_enable] => 1 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [play_audio] => 1 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [say_goodbye] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [play_menulanguage] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [force_language] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [intro_prompt] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [min_credit_2call] => 0 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [min_duration_2bill] => 0 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [notenoughcredit_cardnumber] => 1 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [notenoughcredit_assign_newcardnumber_cid] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [use_dnid] => [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [no_auth_dnid] => Array [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [0] => 2400 [Nov 30 11:33:25] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [1] => 2300 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [force_callplan_id] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [say_balance_after_auth] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [say_balance_after_call] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [say_rateinitial] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [say_timetocall] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [auto_setcallerid] => 1 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [force_callerid] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_sanitize] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_askpincode_ifnot_callerid] => 1 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_assign_card_to_cid] => 1 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_len] => 10 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_typepaid] => POSTPAY [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit] => 0 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit_limit] => 1000 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_tariffgroup] => 6 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [callerid_authentication_over_cardnumber] => 1 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [sip_iax_pstn_direct_call] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [ivr_voucher] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefix] => 8 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [extracharge_did] => Array [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [0] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [extracharge_fee] => Array [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [0] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [dialcommand_param] => |60|HRrL(%timeout%:61000:30000) [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [dialcommand_param_sipiax_friend] => |60|HL(3600000:61000:30000) [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [switchdialcommand] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [failover_recursive_limit] => 2 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [maxtime_tocall_negatif_free_route] => 5400 [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [send_reminder] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [record_call] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [monitor_formatfile] => gsm [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_force_currency] => [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [currency_association] => Array [Nov 30 11:33:26] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [0] => usd:dollars [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [1] => mxn:pesos [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [2] => eur:euros [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [3] => all:credit [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [file_conf_enter_destination] => prepaid-enter-dest [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [file_conf_enter_menulang] => prepaid-menulang2 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [callback_bill_1stleg_ifcall_notconnected] => 1 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [logger_enable] => 1 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [log_file] => /tmp/a2billing.log [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [international_prefixes] => Array [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [0] => 011 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [1] => 09 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [2] => 00 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [3] => 1 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [currency_association_internal] => Array [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [usd] => dollars [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [mxn] => pesos [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [eur] => euros [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [all] => credit [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefixe] => 8 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:76 - IDCONFIG : 3 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:77 - MODE : all-callback [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:89 - AGI Request: [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:90 - Array [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_request] => a2billing.php [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_channel] => SIP/1519821-0884b588 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_language] => en [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_type] => SIP [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_uniqueid] => 1196440405.16 [Nov 30 11:33:27] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_callerid] => 0015147879423 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_calleridname] => 0015147879423 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_callingpres] => 0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_callingani2] => 0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_callington] => 0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_callingtns] => 0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_dnid] => 1519821 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_rdnis] => unknown [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_context] => inbound [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_extension] => 1519821 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_priority] => 3 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_enhanced] => 0.0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [agi_accountcode] => [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:Class.A2Billing.php - line:616 - get_agi_request_parameter = 0015147879423 ; SIP/1519821-0884b588 ; 1196440405.16 ; ; 1519821 [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:555 - [MODE : ALL-CALLBACK - 0015147879423] [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:562 - [ALL CALLBACK TRIGGER RINGING] [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:582 - [resfindrate: - 1] [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:583 - [before find rate] [Nov 30 11:33:28] VERBOSE[6430] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:588 - [find rate ok] [Nov 30 11:33:28] VERBOSE[6430] logger.c: -- AGI Script a2billing.php completed, returning 0 [Nov 30 11:33:28] VERBOSE[6430] logger.c: -- Executing [1519821@inbound:4] Wait("SIP/1519821-0884b588", "60") in new stack [Nov 30 11:33:30] VERBOSE[6430] logger.c: == Spawn extension (inbound, 1519821, 4) exited non-zero on 'SIP/1519821-0884b588' [Nov 30 11:33:30] NOTICE[6430] cdr.c: CDR on channel 'SIP/1519821-0884b588' not posted [Nov 30 11:33:47] VERBOSE[6440] logger.c: == Parsing '/etc/asterisk/manager.conf': [Nov 30 11:33:47] VERBOSE[6440] logger.c: Found [Nov 30 11:33:47] VERBOSE[6440] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Nov 30 11:33:47] VERBOSE[6440] logger.c: Found [Nov 30 11:33:47] VERBOSE[6440] logger.c: == Manager 'myasterisk' logged on from 127.0.0.1 [Nov 30 11:33:56] VERBOSE[6446] logger.c: -- Executing [1000@a2billing-callback:1] AGI("SIP/Globa_Termin-0883d518", "a2billing.php|1|callback") in new stack [Nov 30 11:33:56] VERBOSE[6440] logger.c: == Manager 'myasterisk' logged off from 127.0.0.1 [Nov 30 11:33:56] VERBOSE[6446] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: A2Billing AGI internal configuration: [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: Array [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [debug] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [asterisk_version] => 1_2 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [answer_call] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [play_audio] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [say_goodbye] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [play_menulanguage] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [force_language] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [intro_prompt] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [min_credit_2call] => 0 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [min_duration_2bill] => 0 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [notenoughcredit_cardnumber] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [notenoughcredit_assign_newcardnumber_cid] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [use_dnid] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [no_auth_dnid] => Array [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => 2400 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [1] => 2300 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [number_try] => 3 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [force_callplan_id] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [say_balance_after_auth] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [say_balance_after_call] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [say_rateinitial] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [say_timetocall] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [auto_setcallerid] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [force_callerid] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_sanitize] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_enable] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_askpincode_ifnot_callerid] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_assign_card_to_cid] => 1 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card_len] => 10 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card_typepaid] => POSTPAY [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit] => 0 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit_limit] => 1000 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [cid_auto_create_card_tariffgroup] => 6 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [callerid_authentication_over_cardnumber] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [sip_iax_friends] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call_prefix] => 555 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [ivr_voucher] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [ivr_voucher_prefix] => 8 [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [jump_voucher_if_min_credit] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [extracharge_did] => Array [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => [Nov 30 11:33:57] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [extracharge_fee] => Array [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [international_prefixes] => Array [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => 011 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [1] => 00 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [2] => 09 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [3] => 1 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [dialcommand_param] => |60|HRgrL(%timeout%:61000:30000) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [dialcommand_param_sipiax_friend] => |60|HRgrL(3600000:61000:30000) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [switchdialcommand] => [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [failover_recursive_limit] => 2 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [maxtime_tocall_negatif_free_route] => 5400 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [send_reminder] => [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [record_call] => [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [monitor_formatfile] => gsm [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_force_currency] => [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [currency_association] => Array [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => usd:dollars [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [1] => mxn:pesos [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [2] => eur:euros [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [3] => all:credit [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [file_conf_enter_destination] => prepaid-enter-dest [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [file_conf_enter_menulang] => prepaid-menulang [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [callback_bill_1stleg_ifcall_notconnected] => 1 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [logger_enable] => 1 [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [log_file] => /tmp/a2billing.log [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [currency_association_internal] => Array [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [usd] => dollars [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [mxn] => pesos [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [eur] => euros [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: [all] => credit [Nov 30 11:33:58] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [ivr_voucher_prefixe] => 8 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:76 - IDCONFIG : 1 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:77 - MODE : callback [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:89 - AGI Request: [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:90 - Array [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_request] => a2billing.php [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_channel] => SIP/Globa_Termin-0883d518 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_language] => en [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_type] => SIP [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_uniqueid] => 1196440427.17 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_callerid] => 123456 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_calleridname] => unknown [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_callingpres] => 0 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_callingani2] => 0 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_callington] => 0 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_callingtns] => 0 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_dnid] => unknown [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_rdnis] => unknown [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_context] => a2billing-callback [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_extension] => 1000 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_priority] => 1 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_enhanced] => 0.0 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [agi_accountcode] => [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:616 - get_agi_request_parameter = 123456 ; SIP/Globa_Termin-0883d518 ; 1196440427.17 ; ; 1000 [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:696 - [CALLBACK]:[MODE : CALLBACK] [Nov 30 11:33:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:700 - [CALLBACK]:[ANSWER CALL] [Nov 30 11:33:59] VERBOSE[6446] logger.c: -- Playing 'prepaid-callback_intro' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:02] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:744 - [CALLBACK]:[GET VARIABLE : CALLED=0015147879423 | CALLING= | MODE=ALL | TARIFF=1 | CBID=33833-tptthou | LEG=] [Nov 30 11:34:02] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1769 - Requesting DTMF, CARDNUMBER_LENGTH_MAX 15 [Nov 30 11:34:02] VERBOSE[6446] logger.c: -- Playing 'prepaid-enter-pin-number' (language 'en') [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1771 - RES DTMF : 4667986686 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1775 - CARDNUMBER ::> 4667986686 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1798 - QUERY = SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4667986686' [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: Array [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => Array [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: ( [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [0] => 3.90660 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [credit] => 3.90660 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [1] => 2 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [tariff] => 2 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [2] => t [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [activated] => t [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [3] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [inuse] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [4] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [simultaccess] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [5] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [typepaid] => 0 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [6] => [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [creditlimit] => [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [7] => fr [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [language] => fr [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [8] => 1 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [removeinterprefix] => 1 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [9] => 15143532389 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [redial] => 15143532389 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [10] => 2 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [enableexpire] => 2 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [11] => 1511188455 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(expirationdate)] => 1511188455 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [12] => 90 [Nov 30 11:34:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: [expiredays] => 90 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [13] => 18 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [nbused] => 18 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [14] => 1196209666 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(firstusedate)] => 1196209666 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [15] => 1195569396 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(cc_card.creationdate)] => 1195569396 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [16] => EUR [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [currency] => EUR [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [17] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [lastname] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [18] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [firstname] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [19] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [email] => [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [20] => 3402892505 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [uipass] => 3402892505 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [21] => 1 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [id] => 1 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [22] => -1 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [id_campaign] => -1 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [23] => 1 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [24] => 825326354632819 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [useralias] => 825326354632819 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: ) [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1870 - [SET LANGUAGE() fr] [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='4667986686'] [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1941 - [A2Billing] SAY BALANCE : 3.90660 [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:34:23] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1143 - [CURRENCY : EUR] [Nov 30 11:34:23] VERBOSE[6446] logger.c: -- Playing 'prepaid-you-have' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:24] VERBOSE[6446] logger.c: -- Playing 'digits/2' (language 'fr') [Nov 30 11:34:25] VERBOSE[6446] logger.c: -- Playing 'euros' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:26] VERBOSE[6446] logger.c: -- Playing 'vm-and' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:27] VERBOSE[6446] logger.c: -- Playing 'digits/60' (language 'fr') [Nov 30 11:34:29] VERBOSE[6446] logger.c: -- Playing 'digits/3' (language 'fr') [Nov 30 11:34:29] VERBOSE[6446] logger.c: -- Playing 'prepaid-cents' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:30] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1399 - [AUTO SetCallerID] [Nov 30 11:34:30] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1405 - [REQUESTED SetCallerID : 123456] [Nov 30 11:34:30] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1416 - [EXEC SetCallerID : 123456] [Nov 30 11:34:30] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:772 - [CALLBACK]:[CHANNEL STATUS : 6 = Line is up][status_channel=6]:[ORIG_CREDIT : 3.90660 - CUR_CREDIT - : 1.9533 - CREDIT MIN_CREDIT_2CALL : 0] [Nov 30 11:34:30] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:671 - 0 && && 4&& 0 [Nov 30 11:34:30] VERBOSE[6446] logger.c: -- Playing 'prepaid-enter-dest' (language 'fr') [Nov 30 11:34:53] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:678 - RES DTMF : 0015143532389 [Nov 30 11:34:53] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:696 - DESTINATION ::> 0015143532389 [Nov 30 11:34:53] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:698 - RULES APPLY ON DESTINATION ::> 15143532389 [Nov 30 11:34:54] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:736 - OK - RESFINDRATE::> 1 [Nov 30 11:34:54] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:758 - RES_ALL_CALCULTIMEOUT ::> 1 [Nov 30 11:34:54] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:775 - TIMEOUT::> 11700 : minutes=195 - seconds=0 [Nov 30 11:34:54] VERBOSE[6446] logger.c: -- Playing 'prepaid-you-have' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:55] VERBOSE[6446] logger.c: -- Playing 'digits/hundred' (language 'fr') [Nov 30 11:34:56] VERBOSE[6446] logger.c: -- Playing 'digits/80' (language 'fr') [Nov 30 11:34:57] VERBOSE[6446] logger.c: -- Playing 'digits/15' (language 'fr') [Nov 30 11:34:58] VERBOSE[6446] logger.c: -- Playing 'prepaid-minutes' (escape_digits=#) (sample_offset 0) [Nov 30 11:34:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1012 - app_callingcard: Dialing 'sip/freecalls/15143532389|60|HRgrL(11700000:61000:30000)' with timeout of '11700'. [Nov 30 11:34:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:34:59] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1037 - app_callingcard: CIDGROUPID='-1' OUTBOUND CID SELECTED IS '0'. [Nov 30 11:34:59] VERBOSE[6446] logger.c: -- AGI Script Executing Application: (Dial) Options: (sip/freecalls/15143532389|60|HRgrL(11700000:61000:30000)) [Nov 30 11:34:59] VERBOSE[6446] logger.c: -- Limit Data for this call: [Nov 30 11:34:59] VERBOSE[6446] logger.c: > timelimit = 11700000 [Nov 30 11:34:59] VERBOSE[6446] logger.c: > play_warning = 61000 [Nov 30 11:34:59] VERBOSE[6446] logger.c: > play_to_caller = yes [Nov 30 11:34:59] VERBOSE[6446] logger.c: > play_to_callee = no [Nov 30 11:34:59] VERBOSE[6446] logger.c: > warning_freq = 30000 [Nov 30 11:34:59] VERBOSE[6446] logger.c: > start_sound = (null) [Nov 30 11:34:59] VERBOSE[6446] logger.c: > warning_sound = timeleft [Nov 30 11:34:59] VERBOSE[6446] logger.c: > end_sound = (null) [Nov 30 11:34:59] VERBOSE[6446] logger.c: -- Called freecalls/15143532389 [Nov 30 11:35:00] VERBOSE[6446] logger.c: -- SIP/freecalls-088292d8 is making progress passing it to SIP/Globa_Termin-0883d518 [Nov 30 11:35:09] VERBOSE[6446] logger.c: -- SIP/freecalls-088292d8 answered SIP/Globa_Termin-0883d518 [Nov 30 11:35:31] DEBUG[4851] chan_iax2.c: Raw Hangup 192.168.2.13:4569, src=3, dst=337 [Nov 30 11:36:20] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1139 - -> dialstatus : ANSWER, answered time is 71 [Nov 30 11:36:20] VERBOSE[6446] logger.c: a2billing.php|1|callback: [Nov 30 11:36:20] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1143 - [USEDRATECARD=0] [Nov 30 11:36:20] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196440427.17', 'SIP/Globa_Termin-0883d518', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 71 SECOND , '71', '15143532389', 'ANSWER', now(), '0.01', '+0.02', '', '', 'North america', '2', '2', '1', '2', '123456', '0', '0.005', '0.0059166666666667', '0')] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.02 , redial='15143532389' , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 71 WHERE id_trunk='2' [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 71 WHERE id='2' [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse-1 WHERE username='4667986686'] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:978 - [CALLBACK 1ST LEG]:[INFO FOR THE 1ST LEG - callback_username=4667986686 [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1640 - SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4667986686' [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1714 - [SET LANGUAGE() fr] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='4667986686'] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:984 - [CALLBACK 1ST LEG]:[MAKE BILLING FOR THE 1ST LEG - TARIFF:2;CALLED=0015147879423] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:a2billing.php - line:999 - [CALLBACK]:[RateEngine -> answeredtime=144] [Nov 30 11:36:21] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Nov 30 11:36:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196440427.17', 'SIP/Globa_Termin-0883d518', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 144 SECOND , '144', '0015147879423', 'ANSWERED', now(), '0.01', '+0.03', '', '', 'Montreal2', '2', '2', '4', '2', '123456', '4', '0.005', '0.012', '0')] [Nov 30 11:36:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Nov 30 11:36:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.03 , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Nov 30 11:36:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 144 WHERE id_trunk='2' [Nov 30 11:36:22] VERBOSE[6446] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 144 WHERE id='2' [Nov 30 11:36:22] DEBUG[6446] res_agi.c: SIP/Globa_Termin-0883d518 hungup [Nov 30 11:36:22] VERBOSE[6446] logger.c: == Spawn extension (a2billing-callback, 1000, 1) exited non-zero on 'SIP/Globa_Termin-0883d518' for the second call with wrong billing this is the output [color=green] [Nov 30 11:37:03] VERBOSE[6486] logger.c: -- Executing [1519821@inbound:1] NoOp("SIP/1519821-0883d518", "Incoming call from # 0015147879423") in new stack [Nov 30 11:37:03] VERBOSE[6486] logger.c: -- Executing [1519821@inbound:2] Ringing("SIP/1519821-0883d518", "") in new stack [Nov 30 11:37:03] VERBOSE[6486] logger.c: -- Executing [1519821@inbound:3] DeadAGI("SIP/1519821-0883d518", "a2billing.php|3|all-callback") in new stack [Nov 30 11:37:03] WARNING[6486] res_agi.c: Running DeadAGI on a live channel will cause problems, please use AGI [Nov 30 11:37:03] VERBOSE[6486] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: A2Billing AGI internal configuration: [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: Array [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [debug] => 3 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [asterisk_version] => 1_4 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [answer_call] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [number_try] => 1 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [sip_iax_friends] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [jump_voucher_if_min_credit] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_enable] => 1 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [play_audio] => 1 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [say_goodbye] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [play_menulanguage] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [force_language] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [intro_prompt] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [min_credit_2call] => 0 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [min_duration_2bill] => 0 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [notenoughcredit_cardnumber] => 1 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [notenoughcredit_assign_newcardnumber_cid] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [use_dnid] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [no_auth_dnid] => Array [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [0] => 2400 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [1] => 2300 [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [force_callplan_id] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [say_balance_after_auth] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [say_balance_after_call] => [Nov 30 11:37:03] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [say_rateinitial] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [say_timetocall] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [auto_setcallerid] => 1 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [force_callerid] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_sanitize] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_askpincode_ifnot_callerid] => 1 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_assign_card_to_cid] => 1 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_len] => 10 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_typepaid] => POSTPAY [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit] => 0 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit_limit] => 1000 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_tariffgroup] => 6 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [callerid_authentication_over_cardnumber] => 1 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [sip_iax_pstn_direct_call] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [ivr_voucher] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefix] => 8 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [extracharge_did] => Array [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [0] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [extracharge_fee] => Array [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [0] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [dialcommand_param] => |60|HRrL(%timeout%:61000:30000) [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [dialcommand_param_sipiax_friend] => |60|HL(3600000:61000:30000) [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [switchdialcommand] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [failover_recursive_limit] => 2 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [maxtime_tocall_negatif_free_route] => 5400 [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [send_reminder] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [record_call] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [monitor_formatfile] => gsm [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_force_currency] => [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [currency_association] => Array [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [0] => usd:dollars [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [1] => mxn:pesos [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [2] => eur:euros [Nov 30 11:37:04] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [3] => all:credit [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [file_conf_enter_destination] => prepaid-enter-dest [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [file_conf_enter_menulang] => prepaid-menulang2 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [callback_bill_1stleg_ifcall_notconnected] => 1 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [logger_enable] => 1 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [log_file] => /tmp/a2billing.log [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [international_prefixes] => Array [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [0] => 011 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [1] => 09 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [2] => 00 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [3] => 1 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [currency_association_internal] => Array [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [usd] => dollars [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [mxn] => pesos [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [eur] => euros [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [all] => credit [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefixe] => 8 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:76 - IDCONFIG : 3 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:77 - MODE : all-callback [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:89 - AGI Request: [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:90 - Array [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ( [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_request] => a2billing.php [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_channel] => SIP/1519821-0883d518 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_language] => en [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_type] => SIP [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_uniqueid] => 1196440623.19 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_callerid] => 0015147879423 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_calleridname] => 0015147879423 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_callingpres] => 0 [Nov 30 11:37:05] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_callingani2] => 0 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_callington] => 0 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_callingtns] => 0 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_dnid] => 1519821 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_rdnis] => unknown [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_context] => inbound [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_extension] => 1519821 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_priority] => 3 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_enhanced] => 0.0 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [agi_accountcode] => [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: ) [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:Class.A2Billing.php - line:616 - get_agi_request_parameter = 0015147879423 ; SIP/1519821-0883d518 ; 1196440623.19 ; ; 1519821 [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:555 - [MODE : ALL-CALLBACK - 0015147879423] [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:562 - [ALL CALLBACK TRIGGER RINGING] [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:582 - [resfindrate: - 1] [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:583 - [before find rate] [Nov 30 11:37:06] VERBOSE[6486] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:588 - [find rate ok] [Nov 30 11:37:06] VERBOSE[6486] logger.c: -- AGI Script a2billing.php completed, returning 0 [Nov 30 11:37:06] VERBOSE[6486] logger.c: -- Executing [1519821@inbound:4] Wait("SIP/1519821-0883d518", "60") in new stack [Nov 30 11:37:09] VERBOSE[6486] logger.c: == Spawn extension (inbound, 1519821, 4) exited non-zero on 'SIP/1519821-0883d518' [Nov 30 11:37:09] NOTICE[6486] cdr.c: CDR on channel 'SIP/1519821-0883d518' not posted [Nov 30 11:37:18] VERBOSE[6494] logger.c: == Parsing '/etc/asterisk/manager.conf': [Nov 30 11:37:18] VERBOSE[6494] logger.c: Found [Nov 30 11:37:18] VERBOSE[6494] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Nov 30 11:37:18] VERBOSE[6494] logger.c: Found [Nov 30 11:37:18] VERBOSE[6494] logger.c: == Manager 'myasterisk' logged on from 127.0.0.1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: -- Executing [1000@a2billing-callback:1] AGI("SIP/Globa_Termin-0883d518", "a2billing.php|1|callback") in new stack [Nov 30 11:37:29] VERBOSE[6498] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Nov 30 11:37:29] VERBOSE[6494] logger.c: == Manager 'myasterisk' logged off from 127.0.0.1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: A2Billing AGI internal configuration: [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: Array [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: ( [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [debug] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [asterisk_version] => 1_2 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [answer_call] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [play_audio] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [say_goodbye] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [play_menulanguage] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [force_language] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [intro_prompt] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [min_credit_2call] => 0 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [min_duration_2bill] => 0 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [notenoughcredit_cardnumber] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [notenoughcredit_assign_newcardnumber_cid] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [use_dnid] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [no_auth_dnid] => Array [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: ( [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [0] => 2400 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [1] => 2300 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: ) [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [number_try] => 3 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [force_callplan_id] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [say_balance_after_auth] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [say_balance_after_call] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [say_rateinitial] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [say_timetocall] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [auto_setcallerid] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [force_callerid] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_sanitize] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_enable] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_askpincode_ifnot_callerid] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_assign_card_to_cid] => 1 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card] => [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card_len] => 10 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card_typepaid] => POSTPAY [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit] => 0 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit_limit] => 1000 [Nov 30 11:37:29] VERBOSE[6498] logger.c: a2billing.php|1|callback: [cid_auto_create_card_tariffgroup] => 6 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [callerid_authentication_over_cardnumber] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [sip_iax_friends] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call_prefix] => 555 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [ivr_voucher] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [ivr_voucher_prefix] => 8 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [jump_voucher_if_min_credit] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [extracharge_did] => Array [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ( [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [0] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ) [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [extracharge_fee] => Array [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ( [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [0] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ) [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [international_prefixes] => Array [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ( [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [0] => 011 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [1] => 00 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [2] => 09 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [3] => 1 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: ) [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [dialcommand_param] => |60|HRgrL(%timeout%:61000:30000) [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [dialcommand_param_sipiax_friend] => |60|HRgrL(3600000:61000:30000) [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [switchdialcommand] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [failover_recursive_limit] => 2 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [maxtime_tocall_negatif_free_route] => 5400 [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [send_reminder] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [record_call] => [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [monitor_formatfile] => gsm [Nov 30 11:37:30] VERBOSE[6498] logger.c: a2billing.php|1|callback: [agi_force_currency] => [Nov 30 11:37:30] |
Author: | asiby [ Fri Nov 30, 2007 5:50 pm ] |
Post subject: | |
Do you have pcntl installed in your PHP? And can you confirm if you are using AGI or DeadAGI in your asterisk extension? |
Author: | globaphone [ Fri Nov 30, 2007 8:08 pm ] |
Post subject: | I am using Flash PBX |
Well I am using Dead AGI about pcntl I don't know what is it I don't think that i installed it. I jsut using a voip trunk for termination and I don t have any digium card on my server. Please explain me how to install it (pcmtl). I will try to find more about pcntl on the forum. Thanks asiby Added after 5 minutes: Hi asiby I forgot to tell you I m using flash pbx from http://nerdvittles.com/ so most of the package were installed automatically including php. |
Author: | asiby [ Fri Nov 30, 2007 8:20 pm ] |
Post subject: | |
Well, pcntl, or more precisely php_pcntl is a php extension that enable unix like process control capabilities. If you want to check whether have it or or not, simply do the following in your linux console. Code: # php -m You will see a list of installed php extensions. Here is what I have Code: bz2
ctype date dba dom ftp gd gettext hash iconv imap libxml mbstring mcrypt mhash mysql mysqli ncurses odbc openssl pcntl pcre readline Reflection session SimpleXML soap sockets SPL standard xml zip zlib |
Author: | globaphone [ Sat Dec 01, 2007 5:46 am ] |
Post subject: | i have pcntl |
Hello Asiby I checked with php -m and pcntl is installed . what else do you want me to send you. Regards |
Author: | asiby [ Sat Dec 01, 2007 7:06 am ] |
Post subject: | |
Try this in your extension right before the line containing the DeadAGI Code: exten => <some stuff here>,n,Set(AGISIGHUP=no)
|
Author: | globaphone [ Sat Dec 01, 2007 4:51 pm ] |
Post subject: | |
This is my new Extension but still it does not work. the same probleme with the billing Quote: [inbound] exten => 1519821,1,NoOp(Incoming call from # ${CALLERID(num)}) exten => 1519821,n,Ringing() exten => 1519821,n,Set(AGISIGHUP=no) exten => 1519821,n,DeadAGI(a2billing.php|3|all-callback) exten => 1519821,n,Wait(60) I am using php 5.1.6 |
Author: | asiby [ Sat Dec 01, 2007 7:59 pm ] |
Post subject: | |
You should remove the line containing "Wait(60)" it's useless and asterisk keep using resources for 60 seconds for no reason. How are you initiating the call when trying the callback? From the web callback page, right? |
Author: | globaphone [ Sat Dec 01, 2007 10:42 pm ] |
Post subject: | |
Hi asiby I am using an access number with sipgate wich is registred to my asterisk I call the access number , it rings then i hang up the call back is triggered to my number . so it s not a webcallback. thanks asiby |
Author: | asiby [ Sat Dec 01, 2007 11:56 pm ] |
Post subject: | |
It should be configured as cid-callback then. Even though it is partially working, from what I understand, all-callback is currently best suited for all-callback scheme. What you are doing is cid-callback. |
Author: | globaphone [ Sun Dec 02, 2007 1:13 am ] |
Post subject: | |
hi asiby as i understand the all-callback match exactly my needs, since I want any one to call the access number and after being called back authenticate itself with the pin number. the cid-callback is for registred customers with thieir cid linked to their account, I m not going to use this method at least in the beggining, but I have also the same problem with the cid-callbak, but i didn t try to figure out why it was billing only one leg, since i m not very interested in this callback mode. what can i send you more as info. Please help thanks again |
Author: | globaphone [ Mon Dec 03, 2007 12:02 am ] |
Post subject: | |
Well I am sending you the output of the callback-all when i terminate the call and there is no billing for the second leg ( destination) Quote: [Dec 2 18] VERBOSE[3175] logger.c: -- Executing [1519821@inbound] NoOp("SIP/1519821-093cd388", "Incoming call from # 0015147879423") in new stack [Dec 2 18] VERBOSE[3175] logger.c: -- Executing [1519821@inbound] Ringing("SIP/1519821-093cd388", "") in new stack [Dec 2 18] VERBOSE[3175] logger.c: -- Executing [1519821@inbound] Set("SIP/1519821-093cd388", "AGISIGHUP=no") in new stack [Dec 2 18] VERBOSE[3175] logger.c: -- Executing [1519821@inbound] DeadAGI("SIP/1519821-093cd388", "a2billing.php|3|all-callback") in new stack [Dec 2 18] WARNING[3175] res_agi.c: Running DeadAGI on a live channel will cause problems, please use AGI [Dec 2 18] VERBOSE[3175] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: A2Billing AGI internal configuration: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [debug] => 3 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [asterisk_version] => 1_4 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [answer_call] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [number_try] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [sip_iax_friends] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [jump_voucher_if_min_credit] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_enable] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [play_audio] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [say_goodbye] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [play_menulanguage] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [force_language] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [intro_prompt] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [min_credit_2call] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [min_duration_2bill] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [notenoughcredit_cardnumber] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [notenoughcredit_assign_newcardnumber_cid] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [use_dnid] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [no_auth_dnid] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [0] => 2400 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [1] => 2300 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [force_callplan_id] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [say_balance_after_auth] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [say_balance_after_call] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [say_rateinitial] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [say_timetocall] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [auto_setcallerid] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [force_callerid] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_sanitize] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_askpincode_ifnot_callerid] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_assign_card_to_cid] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_len] => 10 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_typepaid] => POSTPAY [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_credit_limit] => 1000 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [cid_auto_create_card_tariffgroup] => 6 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [callerid_authentication_over_cardnumber] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [sip_iax_pstn_direct_call] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [ivr_voucher] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefix] => 8 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [extracharge_did] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [0] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [extracharge_fee] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [0] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [dialcommand_param] => |60|HRrL(%timeout%:61000:30000) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [dialcommand_param_sipiax_friend] => |60|HL(3600000:61000:30000) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [switchdialcommand] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [failover_recursive_limit] => 2 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [maxtime_tocall_negatif_free_route] => 5400 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [send_reminder] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [record_call] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [monitor_formatfile] => gsm [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_force_currency] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [currency_association] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [0] => usd:dollars [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [1] => mxn:pesos [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [2] => eur:euros [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [3] => all:credit [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [file_conf_enter_destination] => prepaid-enter-dest [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [file_conf_enter_menulang] => prepaid-menulang2 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [callback_bill_1stleg_ifcall_notconnected] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [logger_enable] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [log_file] => /tmp/a2billing.log [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [international_prefixes] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [0] => 011 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [1] => 09 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [2] => 00 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [3] => 1 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [currency_association_internal] => Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [usd] => dollars [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [mxn] => pesos [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [eur] => euros [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [all] => credit [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [ivr_voucher_prefixe] => 8 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:76 - IDCONFIG : 3 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:77 - MODE : all-callback [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:89 - AGI Request: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:90 - Array [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ( [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_request] => a2billing.php [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_channel] => SIP/1519821-093cd388 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_language] => en [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_type] => SIP [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_uniqueid] => 1196637018.0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_callerid] => 0015147879423 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_calleridname] => 0015147879423 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_callingpres] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_callingani2] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_callington] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_callingtns] => 0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_dnid] => 1519821 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_rdnis] => unknown [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_context] => inbound [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_extension] => 1519821 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_priority] => 4 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_enhanced] => 0.0 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [agi_accountcode] => [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: ) [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:Class.A2Billing.php - line:616 - get_agi_request_parameter = 0015147879423 ; SIP/1519821-093cd388 ; 1196637018.0 ; ; 1519821 [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:555 - [MODE : ALL-CALLBACK - 0015147879423] [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:562 - [ALL CALLBACK TRIGGER RINGING] [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:582 - [resfindrate: - 1] [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:583 - [before find rate] [Dec 2 18] VERBOSE[3175] logger.c: a2billing.php|3|all-callback: file:a2billing.php - line:588 - [find rate ok] [Dec 2 18] VERBOSE[3175] logger.c: -- AGI Script a2billing.php completed, returning 0 [Dec 2 18] VERBOSE[3175] logger.c: -- Executing [1519821@inbound] Hangup("SIP/1519821-093cd388", "") in new stack [Dec 2 18] VERBOSE[3175] logger.c: == Spawn extension (inbound, 1519821, 5) exited non-zero on 'SIP/1519821-093cd388' [Dec 2 18] NOTICE[3175] cdr.c: CDR on channel 'SIP/1519821-093cd388' not posted [Dec 2 18] VERBOSE[3184] logger.c: == Parsing '/etc/asterisk/manager.conf': [Dec 2 18] VERBOSE[3184] logger.c: Found [Dec 2 18] VERBOSE[3184] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Dec 2 18] VERBOSE[3184] logger.c: Found [Dec 2 18] VERBOSE[3184] logger.c: == Manager 'myasterisk' logged on from 127.0.0.1 [Dec 2 18] VERBOSE[3188] logger.c: -- Executing [1000@a2billing-callback] AGI("SIP/Globa_Termin-093fd190", "a2billing.php|1|callback") in new stack [Dec 2 18] VERBOSE[3184] logger.c: == Manager 'myasterisk' logged off from 127.0.0.1 [Dec 2 18] VERBOSE[3188] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/a2billing.php [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: A2Billing AGI internal configuration: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [debug] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [asterisk_version] => 1_2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [answer_call] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [play_audio] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [say_goodbye] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [play_menulanguage] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [force_language] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [intro_prompt] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [min_credit_2call] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [min_duration_2bill] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [notenoughcredit_cardnumber] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [notenoughcredit_assign_newcardnumber_cid] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [use_dnid] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [no_auth_dnid] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => 2400 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [1] => 2300 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [number_try] => 3 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [force_callplan_id] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [say_balance_after_auth] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [say_balance_after_call] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [say_rateinitial] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [say_timetocall] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [auto_setcallerid] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [force_callerid] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_sanitize] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_enable] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_askpincode_ifnot_callerid] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_assign_card_to_cid] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card_len] => 10 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card_typepaid] => POSTPAY [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card_credit_limit] => 1000 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [cid_auto_create_card_tariffgroup] => 6 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [callerid_authentication_over_cardnumber] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [sip_iax_friends] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call_prefix] => 555 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [sip_iax_pstn_direct_call] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [ivr_voucher] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [ivr_voucher_prefix] => 8 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [jump_voucher_if_min_credit] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [extracharge_did] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [extracharge_fee] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [international_prefixes] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => 011 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [1] => 00 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [2] => 09 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [3] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [dialcommand_param] => |60|HRgrL(%timeout%:61000:30000) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [dialcommand_param_sipiax_friend] => |60|HRgrL(3600000:61000:30000) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [switchdialcommand] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [failover_recursive_limit] => 2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [maxtime_tocall_negatif_free_route] => 5400 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [send_reminder] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [record_call] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [monitor_formatfile] => gsm [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_force_currency] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [currency_association] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => usd:dollars [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [1] => mxn:pesos [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [2] => eur:euros [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [3] => all:credit [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [file_conf_enter_destination] => prepaid-enter-dest [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [file_conf_enter_menulang] => prepaid-menulang [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [callback_bill_1stleg_ifcall_notconnected] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [logger_enable] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [log_file] => /tmp/a2billing.log [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [currency_association_internal] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [usd] => dollars [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [mxn] => pesos [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [eur] => euros [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [all] => credit [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [ivr_voucher_prefixe] => 8 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:76 - IDCONFIG : 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:77 - MODE : callback [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:89 - AGI Request: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:90 - Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_request] => a2billing.php [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_channel] => SIP/Globa_Termin-093fd190 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_language] => en [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_type] => SIP [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_uniqueid] => 1196637031.1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_callerid] => 123456 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_calleridname] => unknown [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_callingpres] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_callingani2] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_callington] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_callingtns] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_dnid] => unknown [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_rdnis] => unknown [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_context] => a2billing-callback [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_extension] => 1000 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_priority] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_enhanced] => 0.0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [agi_accountcode] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:616 - get_agi_request_parameter = 123456 ; SIP/Globa_Termin-093fd190 ; 1196637031.1 ; ; 1000 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:696 - [CALLBACK]:[MODE : CALLBACK] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:700 - [CALLBACK]:[ANSWER CALL] [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-callback_intro' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:744 - [CALLBACK]:[GET VARIABLE : CALLED=0015147879423 | CALLING= | MODE=ALL | TARIFF=1 | CBID=46695-dlmdvct | LEG=] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1769 - Requesting DTMF, CARDNUMBER_LENGTH_MAX 15 [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-enter-pin-number' (language 'en') [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1771 - RES DTMF : 4666779886686 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1775 - CARDNUMBER ::> 4666779886686 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1798 - QUERY = SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4666779886686' [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1802 - PREPAID-AUTH-FAIL [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-auth-fail' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1761 - PREPAID-AUTH-FAIL [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1769 - Requesting DTMF, CARDNUMBER_LENGTH_MAX 15 [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-enter-pin-number' (language 'en') [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1771 - RES DTMF : 4667986686 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1775 - CARDNUMBER ::> 4667986686 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1798 - QUERY = SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4667986686' [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => Array [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ( [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [0] => 1.85660 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [credit] => 1.85660 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [1] => 2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [tariff] => 2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [2] => t [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [activated] => t [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [3] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [inuse] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [4] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [simultaccess] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [5] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [typepaid] => 0 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [6] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [creditlimit] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [7] => fr [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [language] => fr [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [8] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [removeinterprefix] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [9] => 442083576515 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [redial] => 442083576515 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [10] => 2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [enableexpire] => 2 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [11] => 1511188455 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(expirationdate)] => 1511188455 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [12] => 90 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [expiredays] => 90 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [13] => 28 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [nbused] => 28 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [14] => 1196209666 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(firstusedate)] => 1196209666 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [15] => 1195569396 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [UNIX_TIMESTAMP(cc_card.creationdate)] => 1195569396 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [16] => EUR [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [currency] => EUR [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [17] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [lastname] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [18] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [firstname] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [19] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [email] => [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [20] => 3402892505 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [uipass] => 3402892505 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [21] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [id] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [22] => -1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [id_campaign] => -1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [23] => 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [24] => 825326354632819 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [useralias] => 825326354632819 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: ) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] WARNING[3188] func_language.c: LANGUAGE() is deprecated; use CHANNEL(language) instead. [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1870 - [SET LANGUAGE() fr] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='4667986686'] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1941 - [A2Billing] SAY BALANCE : 1.85660 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1143 - [CURRENCY : EUR] [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-you-have' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'digits/1' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'euros' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'vm-and' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'digits/20' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'digits/5' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-cents' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1399 - [AUTO SetCallerID] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1405 - [REQUESTED SetCallerID : 123456] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1416 - [EXEC SetCallerID : 123456] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:a2billing.php - line:772 - [CALLBACK]:[CHANNEL STATUS : 6 = Line is up][status_channel=6]:[ORIG_CREDIT : 1.85660 - CUR_CREDIT - : 0.9283 - CREDIT MIN_CREDIT_2CALL : 0] [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:671 - 0 && && 4&& 0 [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-enter-dest' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:678 - RES DTMF : 0015145938082 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:696 - DESTINATION ::> 0015145938082 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:698 - RULES APPLY ON DESTINATION ::> 15145938082 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:736 - OK - RESFINDRATE::> 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:758 - RES_ALL_CALCULTIMEOUT ::> 1 [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:775 - TIMEOUT::> 5520 : minutes=92 - seconds=0 [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-you-have' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'digits/80' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'digits/12' (language 'fr') [Dec 2 18] VERBOSE[3188] logger.c: -- Playing 'prepaid-minutes' (escape_digits=#) (sample_offset 0) [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1012 - app_callingcard: Dialing 'sip/freecalls/15145938082|60|HRgrL(5520000:61000:30000)' with timeout of '5520'. [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: [Dec 2 18] VERBOSE[3188] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1037 - app_callingcard: CIDGROUPID='-1' OUTBOUND CID SELECTED IS '0'. [Dec 2 18] VERBOSE[3188] logger.c: -- AGI Script Executing Application: (Dial) Options: (sip/freecalls/15145938082|60|HRgrL(5520000:61000:30000)) [Dec 2 18] VERBOSE[3188] logger.c: -- Limit Data for this call: [Dec 2 18] VERBOSE[3188] logger.c: > timelimit = 5520000 [Dec 2 18] VERBOSE[3188] logger.c: > play_warning = 61000 [Dec 2 18] VERBOSE[3188] logger.c: > play_to_caller = yes [Dec 2 18] VERBOSE[3188] logger.c: > play_to_callee = no [Dec 2 18] VERBOSE[3188] logger.c: > warning_freq = 30000 [Dec 2 18] VERBOSE[3188] logger.c: > start_sound = (null) [Dec 2 18] VERBOSE[3188] logger.c: > warning_sound = timeleft [Dec 2 18] VERBOSE[3188] logger.c: > end_sound = (null) [Dec 2 18] VERBOSE[3188] logger.c: -- Called freecalls/15145938082 [Dec 2 18] VERBOSE[3188] logger.c: -- SIP/freecalls-093c2078 is making progress passing it to SIP/Globa_Termin-093fd190 [Dec 2 18] VERBOSE[3188] logger.c: -- SIP/freecalls-093c2078 answered SIP/Globa_Termin-093fd190 at this time i hang up [Dec 2 18] DEBUG[3188] res_agi.c: SIP/Globa_Termin-093fd190 hungup [Dec 2 18] VERBOSE[3188] logger.c: == Spawn extension (a2billing-callback, 1000, 1) exited non-zero on 'SIP/Globa_Termin-093fd190' and bellow you will find the output difference for the successfull billing Quote: [Dec 2 18:51:54] VERBOSE[3866] logger.c: -- Called freecalls/15145938082
[Dec 2 18:51:54] VERBOSE[3866] logger.c: -- SIP/freecalls-093c2078 is making progress passing it to SIP/Globa_Termin-093fd190 [Dec 2 18:52:04] VERBOSE[3866] logger.c: -- SIP/freecalls-093c2078 answered SIP/Globa_Termin-093fd190 at this point my destination hang up [Dec 2 18:53:55] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1139 - -> dialstatus : ANSWER, answered time is 111 [Dec 2 18:53:55] VERBOSE[3866] logger.c: a2billing.php|1|callback: [Dec 2 18:53:55] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1143 - [USEDRATECARD=0] [Dec 2 18:53:55] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196639452.4', 'SIP/Globa_Termin-093fd190', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 111 SECOND , '111', '15145938082', 'ANSWER', now(), '0.01', '+0.02', '', '', 'North america', '2', '2', '1', '2', '123456', '0', '0.005', '0.00925', '0')] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.02 , redial='15145938082' , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 111 WHERE id_trunk='2' [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 111 WHERE id='2' [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse-1 WHERE username='4667986686'] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:a2billing.php - line:978 - [CALLBACK 1ST LEG]:[INFO FOR THE 1ST LEG - callback_username=4667986686 [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1640 - SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4667986686' [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1714 - [SET LANGUAGE() fr] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='4667986686'] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:a2billing.php - line:984 - [CALLBACK 1ST LEG]:[MAKE BILLING FOR THE 1ST LEG - TARIFF:2;CALLED=0015147879423] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:a2billing.php - line:999 - [CALLBACK]:[RateEngine -> answeredtime=174] [Dec 2 18:53:56] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Dec 2 18:53:57] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196639452.4', 'SIP/Globa_Termin-093fd190', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 174 SECOND , '174', '0015147879423', 'ANSWERED', now(), '0.01', '+0.03', '', '', 'Montreal2', '2', '2', '4', '2', '123456', '4', '0.005', '0.0145', '0')] [Dec 2 18:53:57] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Dec 2 18:53:57] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.03 , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Dec 2 18:53:57] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 174 WHERE id_trunk='2' [Dec 2 18:53:57] VERBOSE[3866] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 174 WHERE id='2' [Dec 2 18:53:57] DEBUG[3866] res_agi.c: SIP/Globa_Termin-093fd190 hungup [Dec 2 18:53:57] VERBOSE[3866] logger.c: == Spawn extension (a2billing-callback, 1000, 1) exited non-zero on 'SIP/Globa_Termin-093fd190' |
Author: | asiby [ Mon Dec 03, 2007 12:05 am ] |
Post subject: | |
No clue. Try activating SIP SET DEBUG and a very high debug level and check every. Specially the SIP messages. |
Author: | globaphone [ Mon Dec 03, 2007 12:37 am ] |
Post subject: | |
Hi asiby Well after some research i succeded to get the log file with more details this is the log with the unsuccessfull billing with me hunging up first Quote: [Dec 3 10:47:41] VERBOSE[2955] logger.c: <--- SIP read from 193.35.17.122:5060 ---> BYE sip:[email protected] SIP/2.0 CSeq: 2 BYE Via: SIP/2.0/UDP 193.35.17.122:5060 From: <sip:[email protected]>;tag=0312440716521978576256421 Call-ID: [email protected] To: "123456" <sip:[email protected]>;tag=as39dbb889 Content-Length: 0 <-------------> [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 0: BYE sip:[email protected] SIP/2.0 (34) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 1: CSeq: 2 BYE (11) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 2: Via: SIP/2.0/UDP 193.35.17.122:5060 (35) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 3: From: <sip:[email protected]>;tag=0312440716521978576256421 (69) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 4: Call-ID: [email protected] (53) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 5: To: "123456" <sip:[email protected]>;tag=as39dbb889 (52) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 6: Content-Length: 0 (17) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 7: (0) [Dec 3 10:47:41] VERBOSE[2955] logger.c: --- (7 headers 0 lines) --- [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: = No match Their Call ID: [email protected] Their Tag 4fa8f7eb71cc68cca91a14abea886308.0f97 Our tag: as03219ff3 [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: = No match Their Call ID: [email protected] Their Tag c21710acc22b10ac47456d6ce729a Our tag: as130c5f33 [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: = Found Their Call ID: [email protected] Their Tag 0312440716521978576256421 Our tag: as39dbb889 [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: **** Received BYE ( 8 ) - Command in SIP BYE [Dec 3 10:47:41] VERBOSE[2955] logger.c: Sending to 193.35.17.122 : 5060 (no NAT) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Setting SIP_ALREADYGONE on dialog [email protected] [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Received bye, issuing owner hangup [Dec 3 10:47:41] VERBOSE[2955] logger.c: <--- Transmitting (no NAT) to 193.35.17.122:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 193.35.17.122:5060;received=193.35.17.122 From: <sip:[email protected]>;tag=0312440716521978576256421 To: "123456" <sip:[email protected]>;tag=as39dbb889 Call-ID: [email protected] CSeq: 2 BYE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Contact: <sip:[email protected]> Content-Length: 0 <------------> [Dec 3 10:47:41] DEBUG[3893] channel.c: Didn't get a frame from channel: SIP/Globa_Termin-090308a0 [Dec 3 10:47:41] DEBUG[3893] channel.c: Bridge stops bridging channels SIP/Globa_Termin-090308a0 and SIP/freecalls-08fdbed8 [Dec 3 10:47:41] DEBUG[3893] channel.c: Hanging up channel 'SIP/freecalls-08fdbed8' [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Hangup call SIP/freecalls-08fdbed8, SIP callid [email protected]) [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: update_call_counter(442083576515) - decrement call limit counter on hangup [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Updating call counter for outgoing call [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Call to peer 'freecalls' removed from call limit 50 [Dec 3 10:47:41] DEBUG[3893] devicestate.c: Notification of state change to be queued on device/channel SIP/freecalls [Dec 3 10:47:41] DEBUG[2949] devicestate.c: No provider found, checking channel drivers for SIP - freecalls [Dec 3 10:47:41] DEBUG[2949] chan_sip.c: Checking device state for peer freecalls [Dec 3 10:47:41] DEBUG[2949] devicestate.c: Changing state for SIP/freecalls - state 1 (Not in use) [Dec 3 10:47:41] DEBUG[3968] app_queue.c: Device 'SIP/freecalls' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. [Dec 3 10:47:41] VERBOSE[3893] logger.c: Scheduling destruction of SIP dialog '[email protected]' in 32000 ms (Method: INVITE) [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Strict routing enforced for session [email protected] [Dec 3 10:47:41] VERBOSE[3893] logger.c: set_destination: Parsing <sip:[email protected]:5060> for address/port to send to [Dec 3 10:47:41] VERBOSE[3893] logger.c: set_destination: set destination to 194.120.0.198, port 5060 [Dec 3 10:47:41] VERBOSE[3893] logger.c: Reliably Transmitting (no NAT) to 194.120.0.198:5060: BYE sip:[email protected]:5060 SIP/2.0 Via: SIP/2.0/UDP 71.51.65.34:5060;branch=z9hG4bK4f0e6024;rport From: "123456" <sip:[email protected]>;tag=as130c5f33 To: <sip:[email protected]>;tag=c21710acc22b10ac47456d6ce729a Call-ID: [email protected] CSeq: 104 BYE User-Agent: Asterisk PBX Max-Forwards: 70 Authorization: Digest username="usernametest", realm="sipdiscount.com", algorithm=MD5, uri="sip:[email protected]:5060", nonce="2974819579", response="caa33176f9bf87e60a5dc8a2abf64943", opaque="" Content-Length: 0 --- [Dec 3 10:47:41] DEBUG[3893] sched.c: Attempted to delete nonexistent schedule entry 0! [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #338 [Dec 3 10:47:41] DEBUG[3893] devicestate.c: Notification of state change to be queued on device/channel SIP/freecalls-08fdbed8 [Dec 3 10:47:41] DEBUG[2949] devicestate.c: No provider found, checking channel drivers for SIP - freecalls [Dec 3 10:47:41] DEBUG[3893] rtp.c: Channel '<unspecified>' has no RTP, not doing anything [Dec 3 10:47:41] DEBUG[2949] chan_sip.c: Checking device state for peer freecalls [Dec 3 10:47:41] DEBUG[2949] devicestate.c: Changing state for SIP/freecalls - state 1 (Not in use) [Dec 3 10:47:41] DEBUG[3893] app_dial.c: Exiting with DIALSTATUS=ANSWER. [Dec 3 10:47:41] DEBUG[3969] app_queue.c: Device 'SIP/freecalls' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. [Dec 3 10:47:41] DEBUG[3893] res_agi.c: SIP/Globa_Termin-090308a0 hungup [Dec 3 10:47:41] DEBUG[3893] pbx.c: Spawn extension (a2billing-callback,1000,1) exited non-zero on 'SIP/Globa_Termin-090308a0' [Dec 3 10:47:41] VERBOSE[3893] logger.c: == Spawn extension (a2billing-callback, 1000, 1) exited non-zero on 'SIP/Globa_Termin-090308a0' [Dec 3 10:47:41] DEBUG[3893] channel.c: Soft-Hanging up channel 'SIP/Globa_Termin-090308a0' [Dec 3 10:47:41] DEBUG[3893] channel.c: Hanging up channel 'SIP/Globa_Termin-090308a0' [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Hangup call SIP/Globa_Termin-090308a0, SIP callid [email protected]) [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: update_call_counter(0015147879423) - decrement call limit counter on hangup [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Updating call counter for outgoing call [Dec 3 10:47:41] DEBUG[3893] chan_sip.c: Call to peer 'Globa_Termin' removed from call limit 50 [Dec 3 10:47:41] DEBUG[3893] devicestate.c: Notification of state change to be queued on device/channel SIP/Globa_Termin [Dec 3 10:47:41] DEBUG[2949] devicestate.c: No provider found, checking channel drivers for SIP - Globa_Termin [Dec 3 10:47:41] DEBUG[3893] devicestate.c: Notification of state change to be queued on device/channel SIP/Globa_Termin-090308a0 [Dec 3 10:47:41] DEBUG[2949] chan_sip.c: Checking device state for peer Globa_Termin [Dec 3 10:47:41] DEBUG[2949] devicestate.c: Changing state for SIP/Globa_Termin - state 1 (Not in use) [Dec 3 10:47:41] DEBUG[2949] devicestate.c: No provider found, checking channel drivers for SIP - Globa_Termin [Dec 3 10:47:41] DEBUG[3893] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. [Dec 3 10:47:41] DEBUG[3970] app_queue.c: Device 'SIP/Globa_Termin' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. [Dec 3 10:47:41] DEBUG[2949] chan_sip.c: Checking device state for peer Globa_Termin [Dec 3 10:47:41] DEBUG[3893] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode) VALUES ('2007-12-03 10:44:48','123456','123456','1000','a2billing-callback', 'SIP/Globa_Termin-090308a0','SIP/freecalls-08fdbed8','Dial','sip/freecalls/442083576515|60|HRgrL(3480000:61000:30000)',173,161,'ANSWERED',3,'') [Dec 3 10:47:41] DEBUG[2949] devicestate.c: Changing state for SIP/Globa_Termin - state 1 (Not in use) [Dec 3 10:47:41] DEBUG[3971] app_queue.c: Device 'SIP/Globa_Termin' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Auto destroying SIP dialog '[email protected]' [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Destroying SIP dialog [email protected] [Dec 3 10:47:41] VERBOSE[2955] logger.c: Really destroying SIP dialog '[email protected]' Method: REGISTER [Dec 3 10:47:41] VERBOSE[2955] logger.c: Really destroying SIP dialog '[email protected]' Method: BYE [Dec 3 10:47:41] VERBOSE[2955] logger.c: <--- SIP read from 194.120.0.198:5060 ---> SIP/2.0 200 Ok Via: SIP/2.0/UDP 71.51.65.34:5060;branch=z9hG4bK4f0e6024;rport From: "123456" <sip:[email protected]>;tag=as130c5f33 To: <sip:[email protected]>;tag=c21710acc22b10ac47456d6ce729a Contact: sip:[email protected]:5060 Call-ID: [email protected] CSeq: 104 BYE Server: (Very nice Sip Registrar/Proxy Server) Allow: ACK,BYE,CANCEL,INVITE,REGISTER,OPTIONS,INFO,MESSAGE Content-Length: 0 <-------------> [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 0: SIP/2.0 200 Ok (14) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 1: Via: SIP/2.0/UDP 71.51.65.34:5060;branch=z9hG4bK4f0e6024;rport (62) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 2: From: "123456" <sip:[email protected]>;tag=as130c5f33 (54) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 3: To: <sip:[email protected]>;tag=c21710acc22b10ac47456d6ce729a (75) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 4: Contact: sip:[email protected]:5060 (44) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 5: Call-ID: [email protected] (53) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 6: CSeq: 104 BYE (13) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 7: Server: (Very nice Sip Registrar/Proxy Server) (46) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 8: Allow: ACK,BYE,CANCEL,INVITE,REGISTER,OPTIONS,INFO,MESSAGE (58 ) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 9: Content-Length: 0 (17) [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Header 10: (0) [Dec 3 10:47:41] VERBOSE[2955] logger.c: --- (10 headers 0 lines) --- [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: = Found Their Call ID: [email protected] Their Tag c21710acc22b10ac47456d6ce729a Our tag: as130c5f33 [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #338 [Dec 3 10:47:41] DEBUG[2955] chan_sip.c: Stopping retransmission on '[email protected]' of Request 104: Match Not Found [Dec 3 10:47:41] VERBOSE[2955] logger.c: Really destroying SIP dialog '[email protected]' Method: INVITE this the log with successfull billing Quote: <-------------> [Dec 3 11:34:04] VERBOSE[2955] logger.c: --- (10 headers 0 lines) --- [Dec 3 11:34:04] VERBOSE[2955] logger.c: Sending to 194.120.0.198 : 5060 (no NAT) [Dec 3 11:34:04] VERBOSE[2955] logger.c: <--- Transmitting (no NAT) to 194.120.0.198:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 194.120.0.198:5060;branch=z9hG4bK5c6f1f71;received=194.120.0.198 From: <sip:[email protected]>;tag=c81710acc82b10ac47454acfeca79 To: "123456" <sip:[email protected]>;tag=as0f5b2818 Call-ID: [email protected] CSeq: 0 BYE User-Agent: Asterisk PBX Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY Supported: replaces Contact: <sip:[email protected]> Content-Length: 0 <------------> [Dec 3 11:34:04] VERBOSE[2955] logger.c: Really destroying SIP dialog '[email protected]' Method: BYE [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1139 - -> dialstatus : ANSWER, answered time is 622 [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:1143 - [USEDRATECARD=0] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196698952.15', 'SIP/Globa_Termin-0902deb8', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 622 SECOND , '622', '442083576515', 'ANSWER', now(), '0.015', '+0.165', '', '', 'UK London', '2', '2', '2', '2', '123456', '0', '0.005', '0.051833333333333', '0')] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.165 , redial='442083576515' , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 622 WHERE id_trunk='2' [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 622 WHERE id='2' [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse-1 WHERE username='4667986686'] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:a2billing.php - line:978 - [CALLBACK 1ST LEG]:[INFO FOR THE 1ST LEG - callback_username=4667986686 [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1640 - SELECT credit, tariff, activated, inuse, simultaccess, typepaid, creditlimit, language, removeinterprefix, redial, enableexpire, UNIX_TIMESTAMP(expirationdate), expiredays, nbused, UNIX_TIMESTAMP(firstusedate), UNIX_TIMESTAMP(cc_card.creationdate), cc_card.currency, cc_card.lastname, cc_card.firstname, cc_card.email, cc_card.uipass, cc_card.id_campaign, cc_card.id, useralias FROM cc_card LEFT JOIN cc_tariffgroup ON tariff=cc_tariffgroup.id WHERE username='4667986686' [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:1714 - [SET LANGUAGE() fr] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.A2Billing.php - line:649 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='4667986686'] [Dec 3 11:34:04] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:a2billing.php - line:984 - [CALLBACK 1ST LEG]:[MAKE BILLING FOR THE 1ST LEG - TARIFF:2;CALLED=0015147879423] [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:a2billing.php - line:999 - [CALLBACK]:[RateEngine -> answeredtime=681] [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:829 - ft2c_package_offer : 0 ; ; 0 [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:900 - [CC_asterisk_stop QUERY = INSERT INTO cc_call (uniqueid,sessionid,username,nasipaddress,starttime,sessiontime, calledstation, terminatecause, stoptime, calledrate, sessionbill, calledcountry, calledsub, destination, id_tariffgroup, id_tariffplan, id_ratecard, id_trunk, src, sipiax, buyrate, buycost, id_card_package_offer) VALUES ('1196698952.15', 'SIP/Globa_Termin-0902deb8', '4667986686', '', CURRENT_TIMESTAMP - INTERVAL 681 SECOND , '681', '0015147879423', 'ANSWERED', now(), '0.01', '+0.12', '', '', 'Montreal2', '2', '2', '4', '2', '123456', '4', '0.005', '0.05675', '0')] [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:903 - [CC_asterisk_stop 1.1: SQL: DONE : result=1] [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:921 - [CC_asterisk_stop 1.2: SQL: UPDATE cc_card SET credit= credit-0.12 , lastuse=now(), nbused=nbused+1 WHERE username='4667986686'] [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:926 - UPDATE cc_trunk SET secondusedreal = secondusedreal + 681 WHERE id_trunk='2' [Dec 3 11:34:05] VERBOSE[5206] logger.c: a2billing.php|1|callback: file:Class.RateEngine.php - line:930 - UPDATE cc_tariffplan SET secondusedreal = secondusedreal + 681 WHERE id='2' [Dec 3 11:34:05] VERBOSE[5206] logger.c: == Spawn extension (a2billing-callback, 1000, 1) exited non-zero on 'SIP/Globa_Termin-0902deb8' [Dec 3 11:34:05] VERBOSE[5206] logger.c: Scheduling destruction of SIP dialog '[email protected]' in 32000 ms (Method: INVITE) [Dec 3 11:34:05] VERBOSE[5206] logger.c: set_destination: Parsing <sip:193.35.17.122:5060;transport=udp> for address/port to send to [Dec 3 11:34:05] VERBOSE[5206] logger.c: set_destination: set destination to 193.35.17.122, port 5060 [Dec 3 11:34:05] VERBOSE[5206] logger.c: Reliably Transmitting (no NAT) to 193.35.17.122:5060: BYE sip:193.35.17.122:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 71.51.65.34:5060;branch=z9hG4bK046da0a0;rport From: "123456" <sip:[email protected]>;tag=as50e70870 To: <sip:[email protected]>;tag=0312220717352001215936433 Call-ID: [email protected] CSeq: 104 BYE User-Agent: Asterisk PBX Max-Forwards: 70 Proxy-Authorization: Digest username="5145859500", realm="VoipSwitch", algorithm=MD5, uri="sip:193.35.17.122:5060", nonce="119669895503170533712223548149", response="e5e200e15149f324feef1e57aceecd95", opaque="" Content-Length: 0 --- [Dec 3 11:34:05] VERBOSE[2955] logger.c: <--- SIP read from 193.35.17.122:5060 ---> SIP/2.0 200 OK CSeq: 104 BYE Via: SIP/2.0/UDP 71.51.65.34:5060;branch=z9hG4bK046da0a0;rport From: "123456" <sip:[email protected]>;tag=as50e70870 Call-ID: [email protected] To: <sip:[email protected]>;tag=0312220717352001215936433 Contact: <sip:193.35.17.122:5060;transport=udp> Content-Length: 0 <-------------> [Dec 3 11:34:05] VERBOSE[2955] logger.c: --- (8 headers 0 lines) --- [Dec 3 11:34:05] VERBOSE[2955] logger.c: Really destroying SIP dialog '[email protected]' Method: INVITE Any clue ? |
Author: | globaphone [ Wed Dec 05, 2007 12:51 pm ] |
Post subject: | Still waiting for any suggestion from you guys |
Any body found the clue, i even changed the first call leg carrier and i got the same problem. and if it sworking for you just tell me wich version is working perfectly for the callback with wich asterisk. I did install the A2b v 1.3 instead of the 1.3.1 and i am resuming the tests and i will get back with my results. It's Working now with v 1.3.0 |
Page 1 of 2 | All times are UTC |
Powered by phpBB © 2000, 2002, 2005, 2007 phpBB Group http://www.phpbb.com/ |