Setup a SIP trunk from UCx250 to IPO500V2 errors 1

[MoJHK]

Dear Expert,

I tried to setup a SIP trunk from UCx250 to IPO500V2 but I got the following error message from logs:

[2024-01-18 17:23:40.071] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:7] Set("UCX/750@750-00000009", "DIAL_NUMBER=") in new stack
[2024-01-18 17:23:40.071] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:8] GosubIf("UCX/750@750-00000009", "1?sub-flp-3,s,1()") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [s@sub-flp-3:1] ExecIf("UCX/750@750-00000009", "0?Set(TARGET_FLP_3=)") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [s@sub-flp-3:2] GotoIf("UCX/750@750-00000009", "0?match") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [s@sub-flp-3:3] Return("UCX/750@750-00000009", "") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:9] Set("UCX/750@750-00000009", "OUTNUM=") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:10] Set("UCX/750@750-00000009", "DIAL_TRUNK_OPTIONS=Tt") in new stack
[2024-01-18 17:23:40.072] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:11] Dial("UCX/750@750-00000009", "SIP/to_IPO/,300,Tt") in new stack
[2024-01-18 17:23:40.073] VERBOSE[6517][C-0000000a] netsock2.c: Using SIP RTP TOS bits 184
[2024-01-18 17:23:40.073] VERBOSE[6517][C-0000000a] netsock2.c: Using SIP RTP CoS mark 5
[2024-01-18 17:23:40.123] ERROR[6517][C-0000000a] netsock2.c: getaddrinfo("to_IPO", "(null)", ...): Name or service not known
[2024-01-18 17:23:40.123] WARNING[6517][C-0000000a] chan_sip.c: No such host: to_IPO
[2024-01-18 17:23:40.123] NOTICE[6517][C-0000000a] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent)
[2024-01-18 17:23:40.123] VERBOSE[6517][C-0000000a] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2024-01-18 17:23:40.123] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:12] Set("UCX/750@750-00000009", "CALLERID(number)=750") in new stack
[2024-01-18 17:23:40.123] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:13] Set("UCX/750@750-00000009", "CALLERID(name)=Pan 750") in new stack
[2024-01-18 17:23:40.123] VERBOSE[6517][C-0000000a] pbx.c: Executing [tdial@ext-trunk:14] Hangup("UCX/750@750-00000009", "") in new stack
[2024-01-18 17:23:40.124] VERBOSE[6517][C-0000000a] pbx.c: Spawn extension (ext-trunk, tdial, 14) exited non-zero on 'UCX/750@750-00000009'
[2024-01-18 17:23:40.124] VERBOSE[6517][C-0000000a] chan_ucx.c: Hanging up UCX/750@750-00000009
[2024-01-18 17:23:55.030] VERBOSE[1580] chan_ucx.c: UCX/750@750-0000000a created for sub 0
[2024-01-18 17:23:55.030] VERBOSE[1580] netsock2.c: Using UCX RTP TOS bits 184
[2024-01-18 17:23:55.030] VERBOSE[1580] netsock2.c: Using UCX RTP CoS mark 5
[2024-01-18 17:23:55.031] VERBOSE[6532] chan_ucx.c: Starting switch on '750@750-0' to 86889
[2024-01-18 17:23:55.031] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:1] Macro("UCX/750@750-0000000a", "user-callerid,LIMIT,EXTERNAL,") in new stack
[2024-01-18 17:23:55.031] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:1] Set("UCX/750@750-0000000a", "TOUCH_MONITOR=1705569835.11") in new stack
[2024-01-18 17:23:55.032] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:2] Set("UCX/750@750-0000000a", "AMPUSER=750") in new stack
[2024-01-18 17:23:55.032] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("UCX/750@750-0000000a", "0?report") in new stack
[2024-01-18 17:23:55.032] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("UCX/750@750-0000000a", "1?Set(REALCALLERIDNUM=750)") in new stack
[2024-01-18 17:23:55.032] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:5] Set("UCX/750@750-0000000a", "AMPUSER=750") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("UCX/750@750-0000000a", "0?limit") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:7] Set("UCX/750@750-0000000a", "AMPUSERCIDNAME=Pan 750") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("UCX/750@750-0000000a", "0?report") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:9] Set("UCX/750@750-0000000a", "AMPUSERCID=750") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:10] Set("UCX/750@750-0000000a", "__DIAL_OPTIONS=Ttr") in new stack
[2024-01-18 17:23:55.033] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("UCX/750@750-0000000a", "1?keepcid") in new stack
[2024-01-18 17:23:55.034] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (macro-user-callerid,s,13)
[2024-01-18 17:23:55.034] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("UCX/750@750-0000000a", "0?limit") in new stack
[2024-01-18 17:23:55.034] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("UCX/750@750-0000000a", "1?Set(GROUP(concurrency_limit)=750)") in new stack
[2024-01-18 17:23:55.034] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("UCX/750@750-0000000a", "0?Set(CHANNEL(language)=)") in new stack
[2024-01-18 17:23:55.034] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("UCX/750@750-0000000a", "1?continue") in new stack
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:29] Set("UCX/750@750-0000000a", "CALLERID(number)=750") in new stack
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:30] Set("UCX/750@750-0000000a", "CALLERID(name)=Pan 750") in new stack
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:31] Set("UCX/750@750-0000000a", "CDR(cnum)=750") in new stack
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:32] Set("UCX/750@750-0000000a", "CDR(cnam)=Pan 750") in new stack
[2024-01-18 17:23:55.035] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@macro-user-callerid:33] Set("UCX/750@750-0000000a", "CHANNEL(language)=en") in new stack
[2024-01-18 17:23:55.036] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:2] Set("UCX/750@750-0000000a", "ROUTE_ID=4") in new stack
[2024-01-18 17:23:55.036] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:3] Set("UCX/750@750-0000000a", "ROUTE_CIDSAVE="Pan 750" <750>") in new stack
[2024-01-18 17:23:55.036] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:4] Set("UCX/750@750-0000000a", "MOHCLASS=default") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:5] Set("UCX/750@750-0000000a", "_NODEST=") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:6] Gosub("UCX/750@750-0000000a", "sub-record-check,s,1(out,86889,)") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:1] Set("UCX/750@750-0000000a", "REC_POLICY_MODE_SAVE=") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:2] GotoIf("UCX/750@750-0000000a", "0?dontrecord") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:3] Set("UCX/750@750-0000000a", "__MON_FMT=WAV") in new stack
[2024-01-18 17:23:55.037] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:4] GotoIf("UCX/750@750-0000000a", "1?next") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (sub-record-check,s,7)
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:7] ExecIf("UCX/750@750-0000000a", "0?Return()") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:8] ExecIf("UCX/750@750-0000000a", "0?Set(__REC_POLICY_MODE=)") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:9] GotoIf("UCX/750@750-0000000a", "0?out,1") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:10] Set("UCX/750@750-0000000a", "__REC_STATUS=INITIALIZED") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:11] Set("UCX/750@750-0000000a", "NOW=1705569835") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:12] Set("UCX/750@750-0000000a", "__DAY=18") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:13] Set("UCX/750@750-0000000a", "__MONTH=01") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:14] Set("UCX/750@750-0000000a", "__YEAR=2024") in new stack
[2024-01-18 17:23:55.038] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:15] Set("UCX/750@750-0000000a", "__TIMESTR=20240118-172355") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:16] Set("UCX/750@750-0000000a", "__FROMEXTEN=750") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:17] Set("UCX/750@750-0000000a", "__CALLFILENAME=out-86889-750-20240118-172355-1705569835.11") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-record-check:18] Goto("UCX/750@750-0000000a", "out,1") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (sub-record-check,out,1)
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [out@sub-record-check:1] ExecIf("UCX/750@750-0000000a", "1?Set(__REC_POLICY_MODE=dontcare)") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [out@sub-record-check:2] GosubIf("UCX/750@750-0000000a", "0?record,1(exten,86889,750)") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [out@sub-record-check:3] Return("UCX/750@750-0000000a", "") in new stack
[2024-01-18 17:23:55.039] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:7] Set("UCX/750@750-0000000a", "CALLERID(all)="Pan 750" <750>") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:8] Set("UCX/750@750-0000000a", "_KEEPCID=TRUE") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [86889@from-internal:9] Goto("UCX/750@750-0000000a", "ext-trunk,3,1") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (ext-trunk,3,1)
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [3@ext-trunk:1] Set("UCX/750@750-0000000a", "TDIAL_STRING=SIP/to_IPO") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [3@ext-trunk:2] Set("UCX/750@750-0000000a", "DIAL_TRUNK=3") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [3@ext-trunk:3] Goto("UCX/750@750-0000000a", "ext-trunk,tdial,1") in new stack
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (ext-trunk,tdial,1)
[2024-01-18 17:23:55.040] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:1] Set("UCX/750@750-0000000a", "OUTBOUND_GROUP=OUT_3") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:2] Set("UCX/750@750-0000000a", "SCA_TAG=") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:3] GotoIf("UCX/750@750-0000000a", "1?nomax") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx_builtins.c: Goto (ext-trunk,tdial,5)
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:5] ExecIf("UCX/750@750-0000000a", "0?Set(CALLERID(name-pres)=)") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:6] ExecIf("UCX/750@750-0000000a", "0?Set(CALLERID(num-pres)=)") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:7] Set("UCX/750@750-0000000a", "DIAL_NUMBER=") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:8] GosubIf("UCX/750@750-0000000a", "1?sub-flp-3,s,1()") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-flp-3:1] ExecIf("UCX/750@750-0000000a", "0?Set(TARGET_FLP_3=)") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-flp-3:2] GotoIf("UCX/750@750-0000000a", "0?match") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [s@sub-flp-3:3] Return("UCX/750@750-0000000a", "") in new stack
[2024-01-18 17:23:55.041] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:9] Set("UCX/750@750-0000000a", "OUTNUM=") in new stack
[2024-01-18 17:23:55.042] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:10] Set("UCX/750@750-0000000a", "DIAL_TRUNK_OPTIONS=Tt") in new stack
[2024-01-18 17:23:55.042] VERBOSE[6532][C-0000000b] pbx.c: Executing [tdial@ext-trunk:11] Dial("UCX/750@750-0000000a", "SIP/to_IPO/,300,Tt") in new stack
[2024-01-18 17:23:55.042] VERBOSE[6532][C-0000000b] netsock2.c: Using SIP RTP TOS bits 184
[2024-01-18 17:23:55.043] VERBOSE[6532][C-0000000b] netsock2.c: Using SIP RTP CoS mark 5
[2024-01-18 17:23:55.069] ERROR[6532][C-0000000b] netsock2.c: getaddrinfo("to_IPO", "(null)", ...): Name or service not known
[2024-01-18 17:23:55.069] WARNING[6532][C-0000000b] chan_sip.c: No such host: to_IPO



Any ideas to resolve it?

 

[curlycord]

Do you have anything to add such as how it's was programmed, any symptoms when calling or what does work if any?
Detail might help the pro's of this system type.

Could even be the IP Office? it does appear the 250 cannot find the 500.

=----(((((((((()----=

http://www.curlycord.com

Toronto, Canada

Add me to LinkedIN

 

[ucxguy]

The SIP trunk configuration on the UCX side is wrong. Based on the log entries you provided, the hostname value appears to be set to "to_IPO". The hostname must be set either to a hostname that can be resolved by DNS or to the IP address of the other system. The text "to_IPO" is not a valid host name.

 

[MoJHK]

Dear @UCXguy,
Thanks for your advise and I did make some changes in UCx250:


Peer detail of the SIP trunk in UCx250:
host=192.168.40.1
type=peer
qualify=no
insecure=very
dtmfmode=rfc2833
context=from-trunk
trustrpid=no
sendrpid=no
canreinvite=no
allow=alaw,ulaw
disallow=all

But after changing the configuration both in UCx250 and IPO500, I still got the following problems:

1. From Ucx250 to IPO
- Incoming call to IPO from UCx250, the IPO extension was ringing and I picked up the IPO phone but it showed it was still "dialling" until timeout. (please refer the attached log file.

2. 1. From IPO to Ucx250
- Incoming call to UCx250 from IPO, the IPO extension showed "WAITIN-FOR-LINE" with fast busy tone.

 

[MoJHK]

Problem resovled.

 

[curlycord]

Please post how it was resolved.
Thanks

=----(((((((((()----=

http://www.curlycord.com

Toronto, Canada

Add me to LinkedIN

 

[MoJHK]

1. From Ucx250 to IPO
- Incoming call to IPO from UCx250, the IPO extension was ringing and I picked up the IPO phone but it showed it was still "dialling" until timeout. (please refer the attached log file.


in UCx250

- Outbound prefix =8 match pattern = . (8 is the access code; destination = .)

in IPO
- ICR "18/." (line group ID =18, Destinations =.)


2. 1. From IPO to Ucx250

- Incoming call to UCx250 from IPO, the IPO extension showed "WAITIN-FOR-LINE" with fast busy tone.

in IPO
- add short code as "86N/dail/N/72" (86 access code, 72 is the ARS)
-ARS "N;/N/18" (line no. 18)


in UCx250

- trunksequence for Matched Routes 0 = IPOffice
-Trunks =IPOffice
- Inbound = IPOffice
- Set Destination Extensions = 740 (extension no.)
- Inbound Routes - add extension 740
- Set Destination = Extensions/740

Hope it can help.

 

[curlycord]

Thanks MoJHK.

It may help somebody one day, but also as one whom helps in trying to fix the issue gets satisfaction for their time spent.

Cheers
cc

=----(((((((((()----=

http://www.curlycord.com

Toronto, Canada

Add me to LinkedIN