provided by Star2Billing S.L.

I have installed a2billing on my trixbox, configured a few rates, trunks etc etc, however when I go to make a call, the user is authenticated fine, I can enter a destination number and it will tell me how much time I have on the call and then will tell me ""the number you have dialed is currently unavailable"

I have attached the log files below. If anyone can identify where the transfer from A2billing to a trunk is going wrong, I would be most grateful.

THanks

Oct 19 16:36:28 DEBUG[2969] chan_sip.c: Setting NAT on RTP to 0
Oct 19 16:36:28 DEBUG[2969] chan_sip.c: Checking SIP call limits for device 6139018xxxx
Oct 19 16:36:28 DEBUG[2969] chan_sip.c: build_route: Record-Route hop:
Oct 19 16:36:28 DEBUG[3506] pbx.c: Expression result is '0'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Function result is '6139018xxxx'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Expression result is '1'
Oct 19 16:36:28 DEBUG[3506] db.c: Unable to find key '8882492063' in family 'blacklist'
Oct 19 16:36:28 DEBUG[3506] db.c: Unable to find key 'gotalk' in family 'blacklist'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Expression result is '0'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Not taking any branch
Oct 19 16:36:28 DEBUG[3506] pbx.c: Function result is 'gotalk'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Expression result is '1'
Oct 19 16:36:28 DEBUG[3506] pbx.c: Function result is '"gotalk" <8882492063>'
Oct 19 16:36:28 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Response 200: Match Found
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: A2Billing AGI internal configuration:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [debug] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [asterisk_version] => 1_2
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [answer_call] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [play_audio] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [say_goodbye] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [play_menulanguage] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [force_language] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [intro_prompt] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [min_credit_2call] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [min_duration_2bill] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [notenoughcredit_cardnumber] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [notenoughcredit_assign_newcardnumber_cid] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [use_dnid] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [no_auth_dnid] => Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [0] => 2400
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [1] => 2300
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [number_try] => 3
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [force_callplan_id] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [say_balance_after_auth] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [say_balance_after_call] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [say_rateinitial] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [say_timetocall] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [auto_setcallerid] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [force_callerid] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_sanitize] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_enable] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_askpincode_ifnot_callerid] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_assign_card_to_cid] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card_len] => 10
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card_typepaid] => POSTPAY
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card_credit] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card_credit_limit] => 1000
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [cid_auto_create_card_tariffgroup] => 6
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [callerid_authentication_over_cardnumber] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [sip_iax_friends] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [sip_iax_pstn_direct_call_prefix] => 555
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [sip_iax_pstn_direct_call] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [ivr_voucher] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [ivr_voucher_prefix] => 8
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [jump_voucher_if_min_credit] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [extracharge_did] => Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [0] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [extracharge_fee] => Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [0] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [dialcommand_param] => |60|HRrL(%timeout%:61000:30000)
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [dialcommand_param_sipiax_friend] => |60|HL(3600000:61000:30000)
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [switchdialcommand] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [failover_recursive_limit] => 2
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [maxtime_tocall_negatif_free_route] => 5400
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [send_reminder] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [record_call] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [monitor_formatfile] => gsm
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_force_currency] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [currency_association] => Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [0] => usd:dollars
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [1] => mxn:pesos
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [2] => eur:euros
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [3] => all:credit
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [file_conf_enter_destination] => prepaid-enter-dest
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [file_conf_enter_menulang] => prepaid-menulang2
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [callback_bill_1stleg_ifcall_notconnected] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [logger_enable] => 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [log_file] => /tmp/a2billing.log
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [currency_association_internal] => Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [usd] => dollars
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [mxn] => pesos
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [eur] => euros
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [all] => credit
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [ivr_voucher_prefixe] => 8
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:75 - IDCONFIG : 1
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:76 - MODE : standard
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:88 - AGI Request:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:89 - Array
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_request] => a2billing.php
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_channel] => SIP/6139018xxxx-086d68c8
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_language] => en
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_type] => SIP
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_uniqueid] => 1192775788.13
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_callerid] => 8882492063
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_calleridname] => gotalk
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_callingpres] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_callingani2] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_callington] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_callingtns] => 0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_dnid] => 6139018xxxx
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_rdnis] => unknown
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_context] => custom-callingcard
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_extension] => s
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_priority] => 3
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_enhanced] => 0.0
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: [agi_accountcode] =>
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:602 - get_agi_request_parameter = 8882492063 ; SIP/6139018xxxx-086d68c8 ; 1192775788.13 ; ; s
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:138 - [ANSWER CALL]
Oct 19 16:36:30 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1799 - Requesting DTMF, CARDNUMBER_LENGTH_MAX 15
Oct 19 16:36:36 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 102: Match Found
Oct 19 16:36:39 DEBUG[3335] manager.c: Manager received command 'Command'
Oct 19 16:36:39 DEBUG[3335] manager.c: Manager received command 'Command'
Oct 19 16:36:39 DEBUG[3335] manager.c: Manager received command 'Command'
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:40 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:41 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:42 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:43 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:44 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:45 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1801 - RES DTMF : 2166347535
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1805 - CARDNUMBER ::> 2166347535
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1828 - 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='2166347535'
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: Array
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [0] => Array
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: (
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [0] => 1000.00000
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [credit] => 1000.00000
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [1] => 2
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [tariff] => 2
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [2] => t
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [activated] => t
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [3] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [inuse] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [4] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [simultaccess] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [5] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [typepaid] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [6] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [creditlimit] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [7] => en
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [language] => en
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [8] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [removeinterprefix] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [9] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [redial] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [10] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [enableexpire] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [11] => 1508381301
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [UNIX_TIMESTAMP(expirationdate)] => 1508381301
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [12] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [expiredays] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [13] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [nbused] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [14] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [UNIX_TIMESTAMP(firstusedate)] => 0
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [15] => 1192765732
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [UNIX_TIMESTAMP(cc_card.creationdate)] => 1192765732
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [16] => AUD
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [currency] => AUD
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [17] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [lastname] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [18] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [firstname] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [19] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [email] =>
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [20] => 7038778854
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [uipass] => 7038778854
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [21] => 4
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [id] => 4
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [22] => -1
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [id_campaign] => -1
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [23] => 4
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [24] => 413301548958887
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: [useralias] => 413301548958887
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: )
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1900 - [SET LANGUAGE() en]
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:635 - [CARD STATUS UPDATE : UPDATE cc_card SET inuse=inuse+1 WHERE username='2166347535']
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1971 - [A2Billing] SAY BALANCE : 1000.00000
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:36:46 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1123 - [CURRENCY : AUD]
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:46 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1428 - [AUTO SetCallerID]
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1434 - [REQUESTED SetCallerID : 8882492063]
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:1445 - [EXEC SetCallerID : 8882492063]
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:169 - [CHANNEL STATUS : 6 = Line is up]
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:170 - [CREDIT : 1000.00000][CREDIT MIN_CREDIT_2CALL : 0]
Oct 19 16:36:55 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:657 - && && 11&& 0
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:00 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:01 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:02 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:03 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:04 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:664 - RES DTMF : 0403xxxxxx
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:682 - DESTINATION ::> 0403xxxxxx
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:684 - RULES APPLY ON DESTINATION ::> 0403xxxxxx
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:722 - OK - RESFINDRATE::> 1
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:744 - RES_ALL_CALCULTIMEOUT ::> 1
Oct 19 16:37:05 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:761 - TIMEOUT::> 59940 : minutes=999 - seconds=0
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:05 NOTICE[3506] rtp.c: Unknown RTP codec 127 received
Oct 19 16:37:10 VERBOSE[3506] logger.c: a2billing.php: file:Class.RateEngine.php - line:962 - app_callingcard: Dialing 'sip/sip.gotalk.com/0403xxxxxx|60|HRrL(59940000:61000:30000)' with timeout of '59940'.
Oct 19 16:37:10 VERBOSE[3506] logger.c: a2billing.php:
Oct 19 16:37:10 VERBOSE[3506] logger.c: a2billing.php: file:Class.RateEngine.php - line:988 - app_callingcard: CIDGROUPID='-1' OUTBOUND CID SELECTED IS '0'.
Oct 19 16:37:10 DEBUG[3506] chan_sip.c: Outgoing Call for 0403xxxxxx
Oct 19 16:37:10 DEBUG[3506] channel.c: Driver for channel 'SIP/6139018xxxx-086d68c8' does not support indication 3, emulating it
Oct 19 16:37:10 DEBUG[2969] chan_sip.c: Acked pending invite 102
Oct 19 16:37:10 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 102: Match Found
Oct 19 16:37:10 DEBUG[3506] chan_sip.c: update_call_counter(0403xxxxxx) - decrement call limit counter
Oct 19 16:37:10 DEBUG[3506] app_dial.c: Exiting with DIALSTATUS=CONGESTION.
Oct 19 16:37:10 VERBOSE[3506] logger.c: a2billing.php: file:Class.RateEngine.php - line:1101 - [USEDRATECARD - FAIL =0]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:Class.RateEngine.php - line:849 - [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 ('1192775788.13', 'SIP/6139018xxxx-086d68c8', '2166347535', '', CURRENT_TIMESTAMP - INTERVAL 0 SECOND , '0', '0403xxxxxx', 'CONGESTION', now(), '1', '-0', '', '', 'Australia Mobile', '2', '3', '5', '3', '8882492063', '0', '1', '0', '0')]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:Class.RateEngine.php - line:852 - [CC_asterisk_stop 1.1: SQL: DONE : result=1]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:295 - [a2billing account stop]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:169 - [CHANNEL STATUS : 6 = Line is up]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:a2billing.php - line:170 - [CREDIT : 1000.00000][CREDIT MIN_CREDIT_2CALL : 0]
Oct 19 16:37:13 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:657 - 0 && && 11&& 1
Oct 19 16:37:21 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:664 - RES DTMF : -1
Oct 19 16:37:21 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:682 - DESTINATION ::> -1
Oct 19 16:37:21 VERBOSE[3506] logger.c: a2billing.php: file:Class.A2Billing.php - line:684 - RULES APPLY ON DESTINATION ::> -1
Oct 19 16:37:21 WARNING[3506] file.c: Failed to write frame
Oct 19 16:37:21 DEBUG[3506] chan_sip.c: update_call_counter(6139018xxxx) - decrement call limit counter
Oct 19 16:37:21 DEBUG[3506] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Oct 19 16:37:21 DEBUG[3506] 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,uniqueid) VALUES ('2007-10-19 16:36:28','8882492063','8882492063','s','custom-callingcard', 'SIP/6139018xxxx-086d68c8','SIP/sip.gotalk.com-08735a50','Dial','sip/sip.gotalk.com/0403xxxxxx|60|HRrL(59940000:61000:30000)',53,53,'ANSWERED',3,'','1192775788.13')
Oct 19 16:37:25 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 102: Match Found
Oct 19 16:37:25 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 102: Match Found
Oct 19 16:37:36 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 102: Match Found
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Scheduled a registration timeout for sip.gotalk.com id #1010
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Scheduled a registration timeout for sip00.mynetfone.com.au id #1012
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 137: Match Found
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Registration successful
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Cancelling timeout 1010
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 137: Match Found
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Registration successful
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Cancelling timeout 1012
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Scheduled a registration timeout for sip.pennytel.com id #1018
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Stopping retransmission on '[email protected]' of Request 138: Match Found
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Registration successful
Oct 19 16:37:40 DEBUG[2969] chan_sip.c: Cancelling timeout 1018
Oct 19 16:38:12 DEBUG[2969] chan_sip.c: Auto destroying call '[email protected]'
Oct 19 16:38:12 DEBUG[2969] chan_sip.c: Auto destroying call '[email protected]'
Oct 19 16:38:12 DEBUG[2969] chan_sip.c: Auto destroying call '[email protected]'
Oct 19 16:38:12 DEBUG[2969] chan_sip.c: Auto destroying call '[email protected]

Evidently your carrier is failing this call to Congestion. Check you are dialing a complete and valid dialstring for your carrier. Most only accept dialstrings in E.164 format, ie starting with the country code.

It may be worth your while to get gotalk.com working to your satisfaction in the Asterisk dialplan before using it within A2B.

I think i fixed that problem, however have another:

Oct 21 01:32:14 NOTICE[2969] chan_sip.c: Failed to authenticate on INVITE to '"8882492063" ;tag=as6c98251c'

My understanding is taht my voip provider is now blocking the call. The password is correct...

anyone?