SIP Phone 8851 Incoming PSTN Not Found, But Outgoing is OK

[okaprasetiyo]

I have the following topology.
voip === switch === CME === SIP === PSTN

The ip phone I use is model 3905, and 8851, all outgoing traffic is functioning properly. The problem arises when there is incoming traffic from PSTN I throw it into the pattern and session 8015, if I target the CUE session I point to SIP Phone 8851, the system says the number you have dialed is wrong.
but if I use SIP Phone 3905, there is no problem.

CME # debug ccsip message

019907: Mar 11 16:48:54.350: //23940/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK095a846f;rport
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as7cec4820
To: <sip:02129783075@172.40.30.49>
Date: Wed, 11 Mar 2020 09:48:54 GMT
Call-ID: 099beaa03bb4adb30d05d6237c5a021e@172.40.30.6:5060
CSeq: 102 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.6.2.T
Session-ID: 00000000000000000000000000000000;remote=49d5cf550d695cefbed343499c3468b7
Content-Length: 0

019908: Mar 11 16:48:54.350: //23941/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:8015@172.16.2.33:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.2.1:5060;branch=z9hG4bK1D01229
Remote-Party-ID: "083148598549" <sip:083148598549@172.16.2.1>;party=calling;screen=no;privacy=off
From: "083148598549" <sip:083148598549@172.16.2.1>;tag=19E382F8-2397
To: <sip:8015@172.16.2.33>
Date: Wed, 11 Mar 2020 09:48:54 GMT
Call-ID: 5AB1D409-62B411EA-A287CD18-C3487515@172.16.2.1
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 1521523641-1655968234-2726415640-3276305685
User-Agent: Cisco-SIPGateway/IOS-15.6.2.T
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1583920134
Contact: <sip:083148598549@172.16.2.1:5060>
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 69
Session-ID: 49d5cf550d695cefbed343499c3468b7;remote=00000000000000000000000000000000
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 185

v=0
o=CiscoSystemsSIP-GW-UserAgent 9526 4671 IN IP4 172.16.2.1
s=SIP Call
c=IN IP4 172.16.2.1
t=0 0
m=audio 17284 RTP/AVP 0
c=IN IP4 172.16.2.1
a=rtpmap:0 PCMU/8000
a=ptime:20

019909: Mar 11 16:48:54.354: //23941/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.16.2.1:5060;branch=z9hG4bK1D01229
From: "083148598549" <sip:083148598549@172.16.2.1>;tag=19E382F8-2397
To: <sip:8015@172.16.2.33>
Call-ID: 5AB1D409-62B411EA-A287CD18-C3487515@172.16.2.1
Session-ID: 15f9259600105000a0000c1167636df0;remote=49d5cf550d695cefbed343499c3468b7
Date: Wed, 11 Mar 2020 09:48:53 GMT
CSeq: 101 INVITE
Server: Cisco-CP8851/11.0.1
Contact: <sip:93D8-B81@172.16.2.33:5060;transport=udp>;+u.sip!devicename.ccm.cisco.com="SEP0C1167636DF0"
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Supported: replaces,join,sdp-anat,norefersub,resource-priority,extended-refer,X-cisco-callinfo,X-cisco-serviceuri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-7.0.0,X-cisco-xsi-8.5.1
Allow-Events: kpml,dialog
Content-Length: 0
Recv-Info: conference
Recv-Info: x-cisco-conference

019910: Mar 11 16:48:54.358: //23941/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Received:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.16.2.1:5060;branch=z9hG4bK1D01229
From: "083148598549" <sip:083148598549@172.16.2.1>;tag=19E382F8-2397
To: <sip:8015@172.16.2.33>;tag=0c1167636df000086e3680ad-1653d395
Call-ID: 5AB1D409-62B411EA-A287CD18-C3487515@172.16.2.1
Session-ID: 15f9259600105000a0000c1167636df0;remote=49d5cf550d695cefbed343499c3468b7
Date: Wed, 11 Mar 2020 09:48:53 GMT
CSeq: 101 INVITE
Server: Cisco-CP8851/11.0.1
Contact: <sip:93D8-B81@172.16.2.33:5060;transport=udp>;+u.sip!devicename.ccm.cisco.com="SEP0C1167636DF0"
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE,INFO
Remote-Party-ID: "Claudia - 112" <sip:112@172.16.2.1>;party=called;id-type=subscriber;privacy=off;screen=yes
Allow-Events: kpml,dialog
Content-Length: 0

019911: Mar 11 16:48:54.358: //23941/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Sent:
ACK sip:8015@172.16.2.33:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.2.1:5060;branch=z9hG4bK1D01229
From: "083148598549" <sip:083148598549@172.16.2.1>;tag=19E382F8-2397
To: <sip:8015@172.16.2.33>;tag=0c1167636df000086e3680ad-1653d395
Date: Wed, 11 Mar 2020 09:48:54 GMT
Call-ID: 5AB1D409-62B411EA-A287CD18-C3487515@172.16.2.1
Max-Forwards: 70
CSeq: 101 ACK
Allow-Events: kpml, telephone-event
Session-ID: ;remote=
Content-Length: 0

019912: Mar 11 16:48:54.358: //23940/5AB09BB9A281/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK095a846f;rport
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as7cec4820
To: <sip:02129783075@172.40.30.49>;tag=19E38304-21B7
Date: Wed, 11 Mar 2020 09:48:54 GMT
Call-ID: 099beaa03bb4adb30d05d6237c5a021e@172.40.30.6:5060
CSeq: 102 INVITE
Allow-Events: telephone-event
Warning: 399 172.40.30.49 "No matching outgoing dial-peer"
Server: Cisco-SIPGateway/IOS-15.6.2.T
Reason: Q.850;cause=1
Session-ID: 00000000000000000000000000000000;remote=49d5cf550d695cefbed343499c3468b7
Content-Length: 0

019913: Mar 11 16:48:54.366: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:02129783075@172.40.30.49 SIP/2.0
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK095a846f;rport
Max-Forwards: 70
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as7cec4820
To: <sip:02129783075@172.40.30.49>;tag=19E38304-21B7
Contact: <sip:083148598549@172.40.30.6:5060>
Call-ID: 099beaa03bb4adb30d05d6237c5a021e@172.40.30.6:5060
CSeq: 102 ACK
User-Agent: BrikerIPPBX
Content-Length: 0

019914: Mar 11 16:48:58.090: %LINEPROTO-5-UPDOWN: Line protocol on Interface ISM0/1, changed state to up
019915: Mar 11 16:49:07.090: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
OPTIONS sip:172.40.30.49 SIP/2.0
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK0df7d799;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@172.40.30.6>;tag=as030661eb
To: <sip:172.40.30.49>
Contact: <sip:Unknown@172.40.30.6:5060>
Call-ID: 2cd0096e2c0647d83497eff14f75aada@172.40.30.6:5060
CSeq: 102 OPTIONS
User-Agent: BrikerIPPBX
Date: Wed, 11 Mar 2020 09:54:53 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0


=============== My Configuration  ===============================

Building configuration...

Current configuration : 12466 bytes
!
! No configuration change since last restart
!
version 15.6
service timestamps debug datetime msec localtime
service timestamps log datetime msec localtime
service password-encryption
service internal
service sequence-numbers
!
hostname CME
!
boot-start-marker
boot system flash0:/c2900-universalk9_npe-mz.SPA.156-2.T.bin
boot-end-marker
!
!
logging queue-limit 10000
logging buffered 1000000
logging rate-limit 10000
no logging console
enable secret 5 xxxxxxxxxxxxxxxxxxxxxxxxx
!
no aaa new-model
ethernet lmi ce
clock timezone Jakarta 7 0
!
!
!
!
!
!
!
!
!
!
!
ip dhcp excluded-address 172.16.2.1 172.16.2.10
!
ip dhcp pool VOICE
network 172.16.2.0 255.255.255.0
default-router 172.16.2.1
option 150 ip 172.16.2.1
!
!
!
ip domain name xxxxx.xxxxx.xxxx
ip name-server xxxxxxxxxxxxxx
ip name-server xxxxxxxxxxxxxxxx
ip cef
no ipv6 cef
multilink bundle-name authenticated
!
!
!
!
!
!
crypto pki trustpoint TP-self-signed-4052548504
enrollment selfsigned
subject-name cn=IOS-Self-Signed-Certificate-4052548504
revocation-check none
rsakeypair TP-self-signed-4052548504
!
!

!
!
voice call send-alert
voice rtp send-recv
!
voice service voip
ip address trusted list
ipv4 117.54.224.81 255.255.255.255
no ip address trusted authenticate
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
no supplementary-service sip moved-temporarily
no supplementary-service sip refer
redirect ip2ip
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
sip
registrar server expires max 3600 min 360
!
voice class codec 1
codec preference 1 g711ulaw
!
voice class h323 1
h225 timeout tcp establish 5
h225 timeout setup 5
telephony-service ccm-compatible
ccm-compatible
!
!
voice class sip-profiles 1
request INVITE sip-header Allow-Header modify ", UPDATE" ""
!
!
!
voice iec syslog
voice register global
mode cme
source-address 172.16.2.1 port 5060
max-dn 144
max-pool 42
load 3905 CP3905.9-4-1SR2-2
timezone 41
date-format D/M/Y
hold-alert
tftp-path flash:
file text
create profile sync 0000007370485196
!
voice register dn 1
!
voice register dn 2
number 101
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Alain B - 101
label Alain B - 101
!
voice register dn 3
number 102
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Ayuhelfia M 102
label Ayuhelfia M - 102

voice register dn 4
number 103
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Oktavia - 103
label Oktavia - 103
!
voice register dn 5
number 104
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Eva Emaria S - 104
label Eva Emaria S - 104
!
voice register dn 6
number 105
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Hery S - 105
label Hery S - 105
!
voice register dn 7
number 106
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Nurcholis - 106
label Nurcholis - 106
!
voice register dn 8
number 107
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Darto - 107
label Darto - 107
!
voice register dn 9
number 108
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Lucky - 108
label Luky - 108
!
voice register dn 10
number 109
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Sales 1 - 109
label Sales 1 - 109
!
voice register dn 11
number 110
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Hendra - 110
label Hendra - 110
!
voice register dn 12
number 111
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name name Meeting Room - 111
label Meeting Room - 111
!
voice register dn 13
number 112
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Claudia - 112
label Claudia - 112
!
voice register dn 14
number 113
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Receptionist-113
label Receptionist-113
!
voice register dn 15
number 114
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Sales Admin - 114
label Sales Admin - 114
!
voice register dn 16
number 115
call-forward b2bua busy 0
pickup-call any-group
pickup-group 80
name Sales 3 - 115
label Sales 3 - 115
!
voice register template 1
button-layout 1-5 line
button-layout 6-23 speed-dial
!
voice register pool 1
!
voice register pool 2
busy-trigger-per-button 1
id mac 3820.5618.CE4C
type 3905
number 1 dn 14
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 3
busy-trigger-per-button 1
id mac 3820.5618.CE57
type 3905
number 1 dn 16
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 4
busy-trigger-per-button 1
id mac 3820.5618.CE6C
type 3905
number 1 dn 4
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 5
busy-trigger-per-button 1
id mac 3820.5618.C9C6
type 3905
number 1 dn 15
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 6
busy-trigger-per-button 1
id mac DCCE.C114.83CD
type 3905
number 1 dn 6
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 7
busy-trigger-per-button 1
id mac 3820.5618.CE71
type 3905
number 1 dn 7
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 8
busy-trigger-per-button 1
id mac 3820.5618.CDAB
type 3905
number 1 dn 8
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 9
busy-trigger-per-button 1
id mac 3820.5618.CC47
type 3905
number 1 dn 9
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 10
busy-trigger-per-button 1
id mac 3820.5618.CD7E
type 3905
number 1 dn 10
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 11
busy-trigger-per-button 1
id mac 0057.D2D1.8913
type 7821
number 1 dn 2
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 12
busy-trigger-per-button 2
id mac 0C11.6763.6DF0
type 8851 addon 1 CKEM
number 1 dn 13
template 1
dtmf-relay sip-kpml
codec g711ulaw
speed-dial 1 101 label "Alain B"
speed-dial 2 102 label "Ayu"
speed-dial 3 103 label "Oktavia"
speed-dial 4 104 label "Eva"
speed-dial 5 105 label "Hery S"
speed-dial 6 106 label "Nurcholis"
speed-dial 7 107 label "Darto"
speed-dial 8 108 label "Luky"
speed-dial 9 109 label "Sales 1"
speed-dial 10 110 label "Hendra"
speed-dial 11 111 label "Meeting Room"
speed-dial 12 113 label "Receptionist"
speed-dial 13 115 label "Sales 3"
!

voice register pool 13
busy-trigger-per-button 1
id mac 3820.5618.CE63
type 3905
number 1 dn 11
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 14
busy-trigger-per-button 1
id mac 0057.D2D1.E23C
type 7821
number 1 dn 5
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 15
busy-trigger-per-button 1
id mac 0057.D2D1.E25F
type 7821
number 1 dn 3
dtmf-relay sip-kpml
codec g711ulaw
!
voice register pool 16
busy-trigger-per-button 1
id mac 0057.D2D1.E214
type 7821
number 1 dn 12
dtmf-relay sip-kpml
codec g711ulaw
!
voice hunt-group 1 sequential
final 200
list 112,113,104,106,103,102,105
timeout 10
pilot 0
!
!
!
!
voice translation-rule 99
rule 1 /02129783075/ /8015/
rule 2 /02129783189/ /8015/
rule 3 /02129783190/ /8015/
rule 4 /02129783191/ /8015/
!
voice translation-rule 100
rule 1 /.*/ /02129783075/
!
voice translation-rule 101
rule 1 /^9/ //
!
!
voice translation-profile INCOMING-SIP-PSTN
translate called 99
!
voice translation-profile OUTGOING-SIP-PSTN
translate calling 100
translate called 101
!
!
!
license udi pid CISCO2911/K9 sn FGL201710YY
hw-module ism 0
!
hw-module pvdm 0/0
!
hw-module pvdm 0/1
!
!
!
file privilege 0
username xxxxxxxxxxxxxx privilege 15 password 7 xxxxxxxxxxxxxxxxxxxxxx
username xxxxxxxxxxxx privilege 15 password 7 xxxxxxxxxxxxxxxxxxxxxxxxxxx
!
redundancy
notification-timer 120000
!
!
!
!
!
!
interface Embedded-Service-Engine0/0
no ip address
shutdown
!
interface GigabitEthernet0/0
no ip address
shutdown
duplex auto
speed auto
!
interface GigabitEthernet0/0.20
encapsulation dot1Q 20
ip address 172.16.1.1 255.255.255.0
!
interface GigabitEthernet0/0.30
encapsulation dot1Q 30
ip address 172.16.2.1 255.255.255.0
!
interface ISM0/0
ip unnumbered GigabitEthernet0/0.30
ip virtual-reassembly in
shutdown
service-module ip address 172.16.2.2 255.255.255.0
!Application: CUE Running on ISM
service-module ip default-gateway 172.16.2.1
!
interface GigabitEthernet0/1
description "Link From PSTN"
ip address 172.20.4.34 255.255.252.0
shutdown
duplex auto
speed auto
h323-gateway voip interface
h323-gateway voip bind srcaddr 172.20.4.34
!
interface GigabitEthernet0/2
ip address 10.10.10.1 255.255.255.0
shutdown
duplex auto
speed auto
!
interface ISM0/1
no ip address
!
interface Vlan1
no ip address
!
ip forward-protocol nd
!
ip http server
ip http authentication local
no ip http secure-server
ip http timeout-policy idle 60 life 86400 requests 10000
ip http path flash:/GUI
!
ip route 0.0.0.0 0.0.0.0 172.20.4.1
ip route 172.16.2.2 255.255.255.255 ISM0/0
!
!
!
tftp-server flash:CP3905.9-4-1SR2-2.loads
tftp-server flash:APP3905.9-4-1SR2-2.zz
!
control-plane
!
!
voice-port 0/0/0
no battery-reversal
!
voice-port 0/0/1
!
voice-port 0/0/2
!
voice-port 0/0/3
!
!
!
!
!
mgcp behavior rsip-range tgcp-only
mgcp behavior comedia-role none
mgcp behavior comedia-check-media-src disable
mgcp behavior comedia-sdp-force disable
!
mgcp profile default
!
!
ccm-manager music-on-hold
!
!
dial-peer voice 1001 voip
translation-profile incoming INCOMING-SIP-PSTN
session protocol sipv2
session target ipv4:117.54.224.81
session transport udp
incoming called-number .
voice-class codec 1
dtmf-relay rtp-nte
fax protocol pass-through g711ulaw
no vad
!
dial-peer voice 1002 voip
translation-profile outgoing OUTGOING-SIP-PSTN
destination-pattern 9.T
session protocol sipv2
session target ipv4:117.54.224.81
session transport udp
voice-class codec 1
voice-class sip early-offer forced
voice-class sip profiles 1
dtmf-relay rtp-nte
fax protocol pass-through g711ulaw
no vad
!
dial-peer voice 8015 voip
description **CUE Auto Attendant**
destination-pattern 8015
session protocol sipv2
session target ipv4:172.16.2.2
dtmf-relay sip-kpml
codec g711ulaw
no vad
!
!
sip-ua
!
!
!
gatekeeper
shutdown
!
!
telephony-service
service directed-pickup gpickup
max-conferences 8 gain -6
call-park system redirect
call-park system application
web admin system name administrator password adminhager
dn-webedit
time-webedit
transfer-system full-consult
fac standard
!
!
!
line con 0
line aux 0
line 2
no activation-character
no exec
transport preferred none
transport output pad telnet rlogin lapb-ta mop udptn v120 ssh
stopbits 1
line 131
no activation-character
no exec
transport preferred none
transport input all
transport output pad telnet rlogin lapb-ta mop udptn v120 ssh
stopbits 1
line vty 0 4
login local
transport input telnet
line vty 5 15
login local
transport input telnet
!
scheduler allocate 20000 1000
ntp master 1
!
end

[Maren Mahoney]

If I'm reading your config correctly, dial-peer voice 8015 points to 172.16.2.2 which is the CUE module on interface ISM0/0. But the ISM0/0 is configured with "shutdown". Might that be the problem or am I missing something?

Maren

[okaprasetiyo]

No, sorry , But 172.16.2.2 is reachable via G0/0.30

[Maren Mahoney]

The installation instructions for ISMs (including deploying CUE on an ISM) are specific about "no shutdown". Try it. Also, if you are using "ip unnumbered" you will want an ip route statement.

Activating IP Connectivity to Cisco Unity Express Software 

Being able to connect to the CUE CLI does not imply that you can route a call to the CUE CLI.

Maren

[okaprasetiyo]

it's an old configuration, my current ISM port configuration is no longer
used

[Maren Mahoney]

Then I'm confused as to what you are trying to do. Your voice translation profile is changing inbound numbers to 8015 (which is reflected in the SIP debugs), and the only other mention of 8015 in your config is dial-peer 8015 which points to CUE on the ISM, which you say you are not running. But in your original problem statement you say you *are* targeting the CUE session on inbound calls.

The debugs show the call coming in, and being routed to 8015@172.16.2.33 via 172.16.2.1 (CME). This IP address is, I assume, the 8851/SEP0C1167636DF0 configured in voice register pool 12, which has DN 112 mapped through voice register dn 13.

If the call is not flowing through the CUE session, how is it getting to any of the 3905 phones as there is no 8015 dn on any of them? If it is flowing through your CUE session, where is CUE if it is not on the ISM?

If you are posting an 'old configuration', do you mean that the current config on your router is different? If so, how can we help troubleshoot if we are not seeing the current config?

Maren

[okaprasetiyo]

I see, sorry I just understood how it works ... thanks for that ....
Right now ISM 0/0 has "gone up", and I have directed Dial-Peer to the target ISM session 0/0 ipv4: 172.16.2.2

then what do I do next ?, the incoming call is still not received

v=0
o=CiscoSystemsSIP-GW-UserAgent 1425 2977 IN IP4 172.40.30.49
s=SIP Call
c=IN IP4 172.40.30.49
t=0 0
m=audio 0 RTP/AVP 18 0 8 9 4 2 15
c=IN IP4 172.40.30.49
m=image 0 udptl t38
c=IN IP4 172.40.30.49
a=T38FaxVersion:0
a=T38MaxBitRate:9600
a=T38FaxRateManagement:transferredTCF
a=T38FaxMaxBuffer:200
a=T38FaxMaxDatagram:320
a=T38FaxUdpEC:t38UDPRedundancy

000121: Mar 20 11:25:26.499: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:02129783075@172.40.30.49 SIP/2.0
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK35debab1;rport
Max-Forwards: 70
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as2a7d1b01
To: <sip:02129783075@172.40.30.49>
Contact: <sip:083148598549@172.40.30.6:5060>
Call-ID: 12bbf61d184bc23879f221761cfe944e@172.40.30.6:5060
CSeq: 102 INVITE
User-Agent: BrikerIPPBX
Date: Fri, 20 Mar 2020 04:31:29 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Type: application/sdp
Content-Length: 247

v=0
o=root 694963078 694963078 IN IP4 172.40.30.6
s=BrikerIPPBX
c=IN IP4 172.40.30.6
t=0 0
m=audio 17254 RTP/AVP 8 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

000122: Mar 20 11:25:26.507: //148/A86F421680A8/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK35debab1;rport
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as2a7d1b01
To: <sip:02129783075@172.40.30.49>
Date: Fri, 20 Mar 2020 04:25:26 GMT
Call-ID: 12bbf61d184bc23879f221761cfe944e@172.40.30.6:5060
CSeq: 102 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.6.2.T
Session-ID: 00000000000000000000000000000000;remote=903a236a45125996bf21be4baf682bc1
Content-Length: 0

000123: Mar 20 11:25:26.511: //149/A86F421680A8/SIP/Msg/ccsipDisplayMsg:
Sent:
INVITE sip:8015@172.16.2.2:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.2.1:5060;branch=z9hG4bK117F4
Remote-Party-ID: "083148598549" <sip:083148598549@172.16.2.1>;party=calling;screen=no;privacy=off
From: "083148598549" <sip:083148598549@172.16.2.1>;tag=256538-14DE
To: <sip:8015@172.16.2.2>
Date: Fri, 20 Mar 2020 04:25:26 GMT
Call-ID: A8707AFE-699911EA-80AE860D-1EBD0D96@172.16.2.1
Supported: 100rel,timer,resource-priority,replaces,sdp-anat
Min-SE: 1800
Cisco-Guid: 2825863702-1771639274-2158528013-0515706262
User-Agent: Cisco-SIPGateway/IOS-15.6.2.T
Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER
CSeq: 101 INVITE
Timestamp: 1584678326
Contact: <sip:083148598549@172.16.2.1:5060>
Expires: 180
Allow-Events: kpml, telephone-event
Max-Forwards: 69
Session-ID: 903a236a45125996bf21be4baf682bc1;remote=00000000000000000000000000000000
Content-Type: application/sdp
Content-Disposition: session;handling=required
Content-Length: 185

v=0
o=CiscoSystemsSIP-GW-UserAgent 8869 6324 IN IP4 172.16.2.1
s=SIP Call
c=IN IP4 172.16.2.1
t=0 0
m=audio 16398 RTP/AVP 0
c=IN IP4 172.16.2.1
a=rtpmap:0 PCMU/8000
a=ptime:20

000124: Mar 20 11:25:27.011: %VOICE_IEC-3-GW: SIP: Internal Error (Socket conn refused): IEC=1.1.186.7.102.1 on callID 149 GUID=A86F4216699911EA80A8860D1EBD0D96
000125: Mar 20 11:25:27.015: //148/A86F421680A8/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 503 Service Unavailable
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK35debab1;rport
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as2a7d1b01
To: <sip:02129783075@172.40.30.49>;tag=256730-2605
Date: Fri, 20 Mar 2020 04:25:26 GMT
Call-ID: 12bbf61d184bc23879f221761cfe944e@172.40.30.6:5060
CSeq: 102 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-15.6.2.T
Reason: Q.850;cause=38
Session-ID: 00000000000000000000000000000000;remote=903a236a45125996bf21be4baf682bc1
Content-Length: 0

000126: Mar 20 11:25:27.019: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:02129783075@172.40.30.49 SIP/2.0
Via: SIP/2.0/UDP 172.40.30.6:5060;branch=z9hG4bK35debab1;rport
Max-Forwards: 70
From: "083148598549" <sip:083148598549@172.40.30.6>;tag=as2a7d1b01
To: <sip:02129783075@172.40.30.49>;tag=256730-2605
Contact: <sip:083148598549@172.40.30.6:5060>
Call-ID: 12bbf61d184bc23879f221761cfe944e@172.40.30.6:5060
CSeq: 102 ACK
User-Agent: BrikerIPPBX
Content-Length: 0

[Maren Mahoney]

The key is the disconnect cause code sent by your router back to the service provider. Q.850;cause=38 means "Network Out of Order". This is reflected by the message the router generated just prior to sending that message that Internal Error (Socket conn refused).

Your router receives the INVITE from the service provider and sends back a Trying message. Then the router sends an INVITE to CUE. Note that the router does not receive any kind of reply from CUE, but immediately sends back the network out of order message back to the service provider. This means that the router is not able to establish a SIP session with CUE.

So, you need to look on CUE itself to see if it is receiving the INVITE and what it is doing with it. It may be a network configuration issue. It may be an issue with CUE program itself. It could be a bunch of things.

Here is a link to troubleshooting CUE hardware/connectivity issues: Unity Express Hardware Troubleshoot Guide 

What I would suggest also is that you re-trace your router-side and CUE-side configuration step-by-step.

FWIW: Other than using sip-kpml rather than sip-notify (and no mwi configuration) the router side of the configuration looks okay. I'm a little concerned that you are not binding SIP to internal and external interfaces on internal and external dial-peers, but I don't know your exact situation.

Take a look and see what you find. If you run into more questions please post again here.

Maren

[okaprasetiyo]

This Appear When i try to open session ,

VG-CME-HAGER#service-module ISM0/0 session
Trying 172.16.2.1, 2131 ... Open
Waiting 83 ...

(INIT)cuehager# MONITOR EXITING...
SAVE TRACE BUFFER
Mar 21 22:04:43 localhost err_handler: CRASH appsServices startup startup.sh System has cr
ashed. The trace buffer information is stored in the file "atrace_save.log". You can upload
the file using "copy log" command
INIT: Sending processe
Rebooting ...

shutdown: sending all processes the TERM signal...
tomcat: INFO tomcat server output MessageResourcesFactory.createFactory

tomcat: INFO tomcat server output java.lang.NullPointerException

tomcat: INFO tomcat server output at java.lang.Class.forName0(Native Method)

tomcat: INFO tomcat server output at java.lang.Class.forName(Class.java:164)

tomcat: INFO tomcat server output at org.apache.struts.util.MessageResourcesFactory.cr
eateFactory(MessageResourcesFactory.java:161)

tomcat: INFO tomcat server output at org.apache.struts.util.MessageResources.getMessag
eResources(MessageResources.java:550)

tomcat: INFO tomcat server output at org.apache.struts.taglib.logic.IterateTag.<clinit
>(IterateTag.java:122)

tomcat: INFO tomcat server output at sun.misc.Unsafe.ensureClassInitialized(Native Met
hod)

tomcat: INFO tomcat server output at sun.reflect.UnsafeFieldAccessorFactory.newFieldAc
cessor(UnsafeFieldAccessorFactory.java:25)

tomcat: INFO tomcat server output at sun.reflect.ReflectionFactory.newFieldAccessor(Re
flectionFactory.java:122)

tomcat: INFO tomcat server output at java.lang.reflect.Field.acquireFieldAccessor(Fiel
d.java:917)

tomcat: INFO tomcat server output at java.lang.reflect.Field.getFieldAccessor(Field.ja
va:898)

tomcat: INFO tomcat server output at java.lang.reflect.Field.set(Field.java:656)

tomcat: INFO tomcat server output at org.apache.catalina.loader.WebappClassLoader.clea
rReferences(WebappClassLoader.java:1644)

tomcat: INFO tomcat server output at org.apache.catalina.loader.WebappClassLoader.stop
(WebappClassLoader.java:1524)

tomcat: INFO tomcat server output at org.apache.catalina.loader.WebappLoader.stop(Weba
ppLoader.java:707)

tomcat: INFO tomcat server output at org.apache.catalina.core.StandardContext.stop(Sta
ndardContext.java:4611)

tomcat: INFO tomcat server output at org.apache.catalina.core.ContainerBase.removeChil
d(ContainerBase.java:924)

tomcat: INFO tomcat server output at org.apache.catalina.startup.HostConfig.undeployAp
ps(HostConfig.java:1248)

tomcat: INFO tomcat server output at org.apache.catalina.startup.HostConfig.stop(HostC
onfig.java:1219)

tomcat: INFO tomcat server output at org.apache.catalina.startup.HostConfig.lifecycleE
vent(HostConfig.java:316)

tomcat: INFO tomcat server output at org.apache.catalina.util.LifecycleSupport.fireLif
ecycleEvent(LifecycleSupport.java:119)

tomcat: INFO tomcat server output at org.apache.catalina.core.ContainerBase.stop(Conta
inerBase.java:1086)

tomcat: INFO tomcat server output at org.apache.catalina.core.ContainerBase.stop(Conta
inerBase.java:1098)

tomcat: INFO tomcat server output at org.apache.catalina.core.StandardEngine.stop(Stan
dardEngine.java:448)

tomcat: INFO tomcat server output at org.apache.catalina.core.StandardService.stop(Sta
ndardService.java:584)

tomcat: INFO tomcat server output at org.apache.catalina.core.StandardServer.stop(Stan
dardServer.java:744)

tomcat: INFO tomcat server output at org.apache.catalina.startup.Catalina.stop(Catalin
a.java:649)

tomcat: INFO tomcat server output at org.apache.catalina.startup.Catalina$CatalinaShut
downHook.run(Catalina.java:692)

sql: INFO sql server output END

tomcat: INFO tomcat server output END

shutdown: sending all processes the KILL signal.
shutdown: turning off swap
shutdown: unmounting all file systems
Please stand by md: stopping all md devices.
while rebooting the system.
ACPI: PCI interrupt for device 0000:01:00.0 disabled
ACPI: PCI interrupt for device 0000:01:01.0 disabled
Restarting system.

Initializing memory. Please wait...
Memory initialization OK. Continue...
DDR Memory 0512 MB detected
Genuine Intel(R) processor 1.06GHz
BIOS ISM 2.6, BIOS Build date: 10/16/2009
System now booting...

Authenticating boot loader....

Secondary Boot Loader authenticated - booting....

Please enter '***' to change boot configuration:

Detect and Initialze network device

Backup current platform configurations....

SRE step 1 - SM registration...

Response - no installation needed (len: 422)

SRE Installation Not Needed

Restoring orignial configuration...

Updating flash with bootloader configuration.
Please wait .................. done.
Loading disk:/bzImage ... Verifying ... done.
Starting Kernel.

Platform: ism
sd 0:0:0:0: [sda] Assuming drive cache: write through
sd 0:0:0:0: [sda] Assuming drive cache: write through
Verifying application level programs
Application level programs verification OK!
INIT: version 2.86 booting
mounting proc fs ...
mounting sys fs ...
mounting /dev/shm tmpfs ...
reiser root fs ...
Reiserfs super block in block 16 on 0x801 of format 3.6 with standard journal
Blocks (total/free): 1002928/876432 by 4096 bytes
Filesystem is clean
Filesystem seems mounted read-only. Skipping journal replay.
Checking internal tree..finished

FILESYSTEM CLEAN
Remounting the root filesystem read-write...

kernel.sem = 1900 4000 32 100
vm.overcommit_memory = 1

Welcome to Cisco Service Engine

Setting the system time from hardware clock

********** rc.aesop ****************
Populating resource values from /etc/ism_rsrc_file
Populating resource values from /etc/default_rsrc_file
Populating resource values from /etc/products/cue/default_rsrc_file
Populating resource values from /etc/products/cue/ism_rsrc_file
Processing manifests . . . . . . . . . . . . complete
==> Management interface is eth0
==> Management interface is eth0

Serial Number: FOC20428LCK
INIT: Entering runlevel: 2
********** rc.post_install ****************
INIT: Switching to runlevel: 4
INIT: Sending processes the TERM signal
==> Starting CDP
STARTED: ntp_startup.sh
STARTED: LDAP_startup.sh
STARTED: SQL_startup.sh
STARTED: dwnldr_startup.sh
STARTED: HTTP_startup.sh
STARTED: probe
STARTED: fndn_udins_wrapper
STARTED: superthread_startup.sh
STARTED: /usr/wfavvid/run-wfengine.sh
STARTED: /usr/bin/launch_ums.sh

Waiting 67 ...^[[B^[[B

(INIT)cuehager# MONITOR EXITING...
SAVE TRACE BUFFER
Mar 21 22:08:28 localhost err_handler: CRASH appsServices startup startup.sh System has crashed. The trace buffer information is stored in the file "atrace_save.log". You
can upload the file using "copy log" command
INIT: Sending processes the TERM signal

Rebooting ...

shutdown: sending all processes the TERM signal...
platform.config: INFO platform.config server output END

trace: INFO trace daemon output END

rbcp: INFO rbcp daemon output END

sql: INFO sql server output END

shutdown: sending all processes the KILL signal.
shutdown: turning off swap
shutdown: unmounting all file systems
Please stand by md: stopping all md devices.
while rebooting the system.
ACPI: PCI interrupt for device 0000:01:00.0 disabled
ACPI: PCI interrupt for device 0000:01:01.0 disabled
Restarting system.

Initializing memory. Please wait...
Memory initialization OK. Continue...
DDR Memory 0512 MB detected
Genuine Intel(R) processor 1.06GHz
BIOS ISM 2.6, BIOS Build date: 10/16/2009
System now booting...

Authenticating boot loader....

Secondary Boot Loader authenticated - booting....

Please enter '***' to change boot configuration:

Detect and Initialze network device

Backup current platform configurations....

SRE step 1 - SM registration...

Response - no installation needed (len: 422)

SRE Installation Not Needed

Restoring orignial configuration...

Updating flash with bootloader configuration.
Please wait .................. done.
Loading disk:/bzImage ... Verifying ... done.
Starting Kernel.

Platform: ism
sd 0:0:0:0: [sda] Assuming drive cache: write through
sd 0:0:0:0: [sda] Assuming drive cache: write through
Verifying application level programs
Application level programs verification OK!
INIT: version 2.86 booting
mounting proc fs ...
mounting sys fs ...
mounting /dev/shm tmpfs ...
reiser root fs ...
Reiserfs super block in block 16 on 0x801 of format 3.6 with standard journal

Blocks (total/free): 1002928/876432 by 4096 bytes
Filesystem is clean
Filesystem seems mounted read-only. Skipping journal replay.
Checking internal tree..finished

FILESYSTEM CLEAN
Remounting the root filesystem read-write...

kernel.sem = 1900 4000 32 100
vm.overcommit_memory = 1

Welcome to Cisco Service Engine

Setting the system time from hardware clock

********** rc.aesop ****************
Populating resource values from /etc/ism_rsrc_file
Populating resource values from /etc/default_rsrc_file
Populating resource values from /etc/products/cue/default_rsrc_file
Populating resource values from /etc/products/cue/ism_rsrc_file
Processing manifests . . . . . . . . . . . . complete
==> Management interface is eth0
==> Management interface is eth0

Serial Number: FOC20428LCK
INIT: Entering runlevel: 2
********** rc.post_install ****************
INIT: Switching to runlevel: 4
INIT: Sending processes the TERM signal
==> Starting CDP
STARTED: ntp_startup.sh
STARTED: LDAP_startup.sh
STARTED: SQL_startup.sh
STARTED: dwnldr_startup.sh
STARTED: HTTP_startup.sh
STARTED: probe
STARTED: fndn_udins_wrapper
STARTED: superthread_startup.sh
STARTED: /usr/wfavvid/run-wfengine.sh
STARTED: /usr/bin/launch_ums.sh



And it's my module status

XXXXXXX#service-module ISM 0/0 status
Service Module is Cisco ISM0/0
Service Module supports session via TTY line 131
Service Module is in Steady state
Service Module heartbeat-reset is enabled
Getting status from the Service Module, please wait..
Cisco Unity Express 8.5.1
CUE Running on ISM

Module resource information:
CPU Frequency: 1064 MHz
Memory Size: 513168 MB
Disk 0 Size: 7840 MB

No install/uninstall in progress

No localstore