No outbound Freepbx and Voip.ms

Please help i have No outbound Freepbx and Voip.ms. inbound is working…
freepbx version
PBX Firmware:10.13.66-20
PBX Service Pack:1.0.0.0

Outbound peer details

canreinvite=nonat
nat=yes
context=from-trunk
host=newyork2.voip.ms ;
username=2xxxxx ;
fromuser=2xxxxx ;
secret=xxxxxxx ;
type=peer
disallow=all
allow=ulaw
; allow=g729 ;
trustrpid=yes
sendrpid=yes
insecure=invite
qualify=yes

Outbound Dialing pattern
1NXXNXXXXXX
4XXX
1(Prepend) NXXNXXXXXX

Trunk looks like its registering
newyork2.voip.ms:5060 Y 2XXX39 105 Registered Tue, 01 Aug 2017 14:17:48

Log file

[2017-08-01 14:03:48] VERBOSE[2312] netsock2.c: Using SIP TOS bits 96
[2017-08-01 14:03:48] VERBOSE[2312] netsock2.c: Using SIP CoS mark 4
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_general_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_general_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_registrations_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_registrations.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/iax_custom_post.conf’: Found
[2017-08-01 14:03:48] WARNING[3808] iax2/firmware.c: Error opening firmware directory ‘/var/lib/asterisk/firmware/iax’: No such file or directory
[2017-08-01 14:03:48] NOTICE[3808] iax2/provision.c: No IAX provisioning configuration found, IAX provisioning disabled.
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘res_pjsip_outbound_registration.so’ (PJSIP Outbound Registration Support)
[2017-08-01 14:03:48] ERROR[3808] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘res_pjsip_notify.so’ (CLI/AMI PJSIP NOTIFY Support)
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/pjsip_notify.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/sip_notify_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/sip_notify_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘res_adsi.so’ (ADSI Resource)
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_meetme.so’ (MeetMe conference bridge)
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/meetme.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/meetme_general_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/meetme_general_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/meetme_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_confbridge.so’ (Conference Bridge Application)
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/confbridge.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/confbridge_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/confbridge_custom.conf’: Found
[2017-08-01 14:03:48] NOTICE[3808] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘cel_manager.so’ (Asterisk Manager Interface CEL Backend)
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel_general_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel_general_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel_custom_post.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘cel_odbc.so’ (ODBC CEL backend)
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel_odbc.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/cel_odbc_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] cel_odbc.c: Found CEL table cel@asteriskcdrdb.
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/voicemail.conf’: Found
[2017-08-01 14:03:48] WARNING[3808] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages
[2017-08-01 14:03:48] VERBOSE[2312] config.c: Parsing ‘/etc/asterisk/sip_notify.conf’: Found
[2017-08-01 14:03:48] VERBOSE[2312] config.c: Parsing ‘/etc/asterisk/sip_notify_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[2312] config.c: Parsing ‘/etc/asterisk/sip_notify_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_playback.so’ (Sound File Playback Application)
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_flite.so’ (Flite TTS Interface)
[2017-08-01 14:03:48] WARNING[3808] app_flite.c: Flite: Unable to read config file flite.conf. Using default settings
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘codec_dahdi.so’ (Generic DAHDI Transcoder Codec Translator)
[2017-08-01 14:03:48] VERBOSE[3808] loader.c: Reloading module ‘app_queue.so’ (True Call Queueing)
[2017-08-01 14:03:48] NOTICE[3808] app_queue.c: queuerules.conf has not changed since it was last loaded. Not taking any action.
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues_general_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues_custom_general.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues_additional.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] config.c: Parsing ‘/etc/asterisk/queues_post_custom.conf’: Found
[2017-08-01 14:03:48] VERBOSE[3808] asterisk.c: Remote UNIX connection disconnected
[2017-08-01 14:03:48] VERBOSE[3773][C-00000000] res_agi.c: <SIP/204-00000000>AGI Script sangomacrm.agi completed, returning 0
[2017-08-01 14:03:48] VERBOSE[3773][C-00000000] pbx.c: Executing [s@crm-hangup:8] Return(“SIP/204-00000000”, “”) in new stack
[2017-08-01 14:03:48] VERBOSE[3773][C-00000000] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/204-00000000’
[2017-08-01 14:03:48] VERBOSE[3773][C-00000000] app_stack.c: SIP/204-00000000 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
[2017-08-01 14:10:50] VERBOSE[2312][C-00000001] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-01 14:10:50] VERBOSE[2312][C-00000001] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:1] Macro(“SIP/200-00000002”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:1] Set(“SIP/200-00000002”, “TOUCH_MONITOR=1501611050.34”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:2] Set(“SIP/200-00000002”, “AMPUSER=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“SIP/200-00000002”, “0?report”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“SIP/200-00000002”, “1?Set(REALCALLERIDNUM=200)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:5] Set(“SIP/200-00000002”, “AMPUSER=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“SIP/200-00000002”, “0?limit”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:7] Set(“SIP/200-00000002”, “AMPUSERCIDNAME=Richard Hendricks”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“SIP/200-00000002”, “0?report”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:9] Set(“SIP/200-00000002”, “AMPUSERCID=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:10] Set(“SIP/200-00000002”, “__DIAL_OPTIONS=Ttr”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:11] Set(“SIP/200-00000002”, “CALLERID(all)=“Richard Hendricks” <200>”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:12] GotoIf(“SIP/200-00000002”, “0?limit”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“SIP/200-00000002”, “1?Set(GROUP(concurrency_limit)=200)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“SIP/200-00000002”, “0?Set(CHANNEL(language)=)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:15] GotoIf(“SIP/200-00000002”, “1?continue”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:29] Set(“SIP/200-00000002”, “CALLERID(number)=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:30] Set(“SIP/200-00000002”, “CALLERID(name)=Richard Hendricks”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:31] GotoIf(“SIP/200-00000002”, “0?cnum”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:32] Set(“SIP/200-00000002”, “CDR(cnam)=Richard Hendricks”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:33] Set(“SIP/200-00000002”, “CDR(cnum)=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-user-callerid:34] Set(“SIP/200-00000002”, “CHANNEL(language)=en”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:2] Gosub(“SIP/200-00000002”, “sub-record-check,s,1(out,1xxxxxx3291,dontcare)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/200-00000002”, “0?initialized”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/200-00000002”, “__REC_STATUS=INITIALIZED”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/200-00000002”, “NOW=1501611050”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/200-00000002”, “__DAY=01”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/200-00000002”, “__MONTH=08”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/200-00000002”, “__YEAR=2017”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/200-00000002”, “__TIMESTR=20170801-141050”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/200-00000002”, “__FROMEXTEN=200”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/200-00000002”, “__MON_FMT=wav”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/200-00000002”, “Recordings initialized”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/200-00000002”, “0?Set(ARG3=dontcare)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/200-00000002”, “REC_POLICY_MODE_SAVE=”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/200-00000002”, “0?Set(REC_STATUS=NO)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/200-00000002”, “3?checkaction”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/200-00000002”, “1?sub-record-check,out,1”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (sub-record-check,out,1)
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [out@sub-record-check:1] NoOp(“SIP/200-00000002”, “Outbound Recording Check from 200 to 1xxxxxx3291”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [out@sub-record-check:2] Set(“SIP/200-00000002”, “RECMODE=dontcare”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [out@sub-record-check:3] ExecIf(“SIP/200-00000002”, “1?Goto(routewins)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (sub-record-check,out,7)
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [out@sub-record-check:7] Gosub(“SIP/200-00000002”, “recordcheck,1(dontcare,out,1xxxxx3291)”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/200-00000002”, “Starting recording check against dontcare”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/200-00000002”, “dontcare”) in new stack
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-08-01 14:10:50] VERBOSE[4539][C-00000001] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [out@sub-record-check:8] Return(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:3] ExecIf(“SIP/200-00000002”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:4] Set(“SIP/200-00000002”, “MOHCLASS=default”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:5] ExecIf(“SIP/200-00000002”, “1?Set(TRUNKCIDOVERRIDE=2035833636)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:6] Set(“SIP/200-00000002”, “_NODEST=”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:7] Macro(“SIP/200-00000002”, “dialout-trunk,1,1xxxxxx3291,off”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“SIP/200-00000002”, “DIAL_TRUNK=1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/200-00000002”, “0?sub-pincheck,s,1()”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/200-00000002”, “0?disabletrunk,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:4] Set(“SIP/200-00000002”, “DIAL_NUMBER=1xxxxxx3291”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“SIP/200-00000002”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“SIP/200-00000002”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/200-00000002”, “1?nomax”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,s,9)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/200-00000002”, “0?skipoutcid”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:10] Set(“SIP/200-00000002”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:11] Macro(“SIP/200-00000002”, “outbound-callerid,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/200-00000002”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/200-00000002”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf(“SIP/200-00000002”, “0?Set(REALCALLERIDNUM=200)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:4] GotoIf(“SIP/200-00000002”, “1?normcid”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-outbound-callerid,s,7)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:7] Set(“SIP/200-00000002”, “USEROUTCID=”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:8] Set(“SIP/200-00000002”, “EMERGENCYCID=”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:9] Set(“SIP/200-00000002”, “TRUNKOUTCID=2035833636”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:10] GotoIf(“SIP/200-00000002”, “1?trunkcid”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-outbound-callerid,s,15)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/200-00000002”, “1?Set(CALLERID(all)=2035833636)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/200-00000002”, “0?Set(CALLERID(all)=)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/200-00000002”, “1?Set(CALLERID(all)=2035833636)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf(“SIP/200-00000002”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf(“SIP/200-00000002”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:20] Set(“SIP/200-00000002”, “CDR(outbound_cnum)=2035833636”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outbound-callerid:21] Set(“SIP/200-00000002”, “CDR(outbound_cnam)=”) in new stack
[2017-08-01 14:10:51] WARNING[2095] func_cdr.c: CDR requires a value (CDR(variable)=value)
)[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/200-00000002”, “0?sub-flp-1,s,1()”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:13] Set(“SIP/200-00000002”, “OUTNUM=1xxxxxx3291”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“SIP/200-00000002”, “custom=SIP/Voipms”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/200-00000002”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/200-00000002”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:17] Macro(“SIP/200-00000002”, “dialout-trunk-predial-hook,”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/200-00000002”, “0?skipcrm”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:19] Set(“SIP/200-00000002”, “__CRM_DIRECTION=OUTBOUND”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:20] Set(“SIP/200-00000002”, “__CRM_DESTINATION=1xxxxxx3291”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:21] Set(“SIP/200-00000002”, “__CRM_SOURCE=200”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:22] AGI(“SIP/200-00000002”, “sangomacrm.agi”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] res_agi.c: <SIP/200-00000002>AGI Script sangomacrm.agi completed, returning 0
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:23] Set(“SIP/200-00000002”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:24] NoOp(“SIP/200-00000002”, “CRM Finished”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:25] GotoIf(“SIP/200-00000002”, “0?bypass,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:26] ExecIf(“SIP/200-00000002”, “1?Set(CONNECTEDLINE(num,i)=1xxxxxx3291)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:27] ExecIf(“SIP/200-00000002”, “1?Set(CONNECTEDLINE(name,i)=CID:2035833636)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf(“SIP/200-00000002”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)2035833636)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:29] GotoIf(“SIP/200-00000002”, “0?customtrunk”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:30] Dial(“SIP/200-00000002”, “SIP/Voipms/1xxxxxx3291,300,T”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] netsock2.c: Using SIP RTP TOS bits 184
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] netsock2.c: Using SIP RTP CoS mark 5
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] app_dial.c: Called SIP/Voipms/1xxxxxx3291
[2017-08-01 14:10:51] WARNING[2312][C-00000001] chan_sip.c: Received response: “Forbidden” from ‘sip:[email protected]:5160;tag=as3b72db9e’
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:31] NoOp(“SIP/200-00000002”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-dialout-trunk:32] GotoIf(“SIP/200-00000002”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set(“SIP/200-00000002”, “RC=21”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto(“SIP/200-00000002”, “21,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [21@macro-dialout-trunk:1] Goto(“SIP/200-00000002”, “continue,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp(“SIP/200-00000002”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf(“SIP/200-00000002”, “1?Set(CALLERID(number)=200)”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [1xxxxxx3291@from-internal:8] Macro(“SIP/200-00000002”, “outisbusy,”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outisbusy:1] Progress(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outisbusy:2] GotoIf(“SIP/200-00000002”, “0?emergency,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outisbusy:3] GotoIf(“SIP/200-00000002”, “0?intracompany,1”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outisbusy:4] Playback(“SIP/200-00000002”, “all-circuits-busy-now&please-try-call-later, noanswer”) in new stack
[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] file.c: <SIP/200-00000002> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
[2017-08-01 14:10:53] VERBOSE[4539][C-00000001] file.c: <SIP/200-00000002> Playing ‘please-try-call-later.ulaw’ (language ‘en’)
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-outisbusy:5] Congestion(“SIP/200-00000002”, “20”) in new stack
[2017-08-01 14:10:55] WARNING[4539][C-00000001] channel.c: Prodding channel ‘SIP/200-00000002’ failed
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/200-00000002’ in macro ‘outisbusy’
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Spawn extension (from-internal, 1xxxxxxx91, 8) exited non-zero on ‘SIP/200-00000002’
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [h@from-internal:1] Macro(“SIP/200-00000002”, “hangupcall”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“SIP/200-00000002”, “1?theend”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“SIP/200-00000002”, “0?Set(CDR(recordingfile)=)”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@macro-hangupcall:4] Hangup(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/200-00000002’ in macro ‘hangupcall’
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/200-00000002’
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] app_stack.c: SIP/200-00000002 Internal Gosub(crm-hangup,s,1) start
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:1] NoOp(“SIP/200-00000002”, “Sending Hangup to CRM”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:2] NoOp(“SIP/200-00000002”, “HANGUP CAUSE: 34”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:3] ExecIf(“SIP/200-00000002”, “0?Set(__CRM_VOICEMAIL=)”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:4] NoOp(“SIP/200-00000002”, “MASTER CHANNEL: 1501611050.34 = 1501611050.34”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:5] GotoIf(“SIP/200-00000002”, “0?return”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:6] Set(“SIP/200-00000002”, “__CRM_HANGUP=1”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:7] AGI(“SIP/200-00000002”, “sangomacrm.agi”) in new stack
[2017-08-01 14:10:55] VERBOSE[4539][C-00000001] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2017-08-01 14:10:56] VERBOSE[4539][C-00000001] res_agi.c: <SIP/200-00000002>AGI Script sangomacrm.agi completed, returning 0
[2017-08-01 14:10:56] VERBOSE[4539][C-00000001] pbx.c: Executing [s@crm-hangup:8] Return(“SIP/200-00000002”, “”) in new stack
[2017-08-01 14:10:56] VERBOSE[4539][C-00000001] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘SIP/200-00000002’
[2017-08-01 14:10:56] VERBOSE[4539][C-00000001] app_stack.c: SIP/200-00000002 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

[2017-08-01 14:10:51] VERBOSE[4539][C-00000001] app_dial.c: Called SIP/Voipms/12032433291
[2017-08-01 14:10:51] WARNING[2312][C-00000001] chan_sip.c: Received response: "Forbidden" from ';tag=as3b72db9e'

Looks like your trunk credentials are wrong in Peer Details.

1 Like

Fixed… Thanks you… i had a ; after the password

1 Like