Re: Sent: SIP/2.0 500 Internal Server Error

colcha · ‎09-12-2023

I have a problem with the forwarding of external calls.

The client has an IPECS PBX, the telephones can make internal diversions without problem.
When the phones activate the external forwarding, it doesn't work.
The scenario is the following:

Telephone number 71 You have the external diversion activated.

When they call the number XXXXXX-71, this user does not receive the call. (This extension 77 has external forwarding activated)

then I add the "ccsip messages"
Here is the message: SIP/2.0 500 Internal Server Error

Example : External Call (+49 XXXXXX14) ------> +49 xxxxx71 --> Extension 71 ( FW --> Forward to a mobile number )

----

005020: Aug 2 09:07:45.911: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:+49XXXXXXX71@tel.t-online.de:5060;transport=tcp;user=phone SIP/2.0

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

Record-Route: <sip:stat.sip-trunk.telekom.de;transport=tcp;lr>

Max-Forwards: 62

To: <sip:+49XXXXXXX71@telekom.de;user=phone>

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

Call-ID: 987c18c2009f09fd@87.137.173.231

Contact: <sip:niHuIyCRnwOs7+T6NzPmpKxZlHGeDdw5jmEbNYAV6BBw22gmwguJwqk0GvZ1clgHCxns@th1>

Supported: 199,histinfo

CSeq: 50054372 INVITE

Allow: ACK, BYE, CANCEL, INVITE, NOTIFY, OPTIONS, PRACK, PUBLISH, REFER, REGISTER, SUBSCRIBE, UPDATE

Expires: 180

P-Asserted-Identity: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>

P-Called-Party-ID: <sip:+49XXXXXXX71@sip-trunk.telekom.de;user=phone>

Session-ID: 4b010d0b5588618076c77bca71510793;remote=00000000000000000000000000000000

Content-Type: application/sdp

Content-Disposition: session

Content-Length: 233

v=0

o=- 89723675773290 89723675773290 IN IP4 217.0.129.100

s=on transit

c=IN IP4 217.0.133.117

t=0 0

m=audio 20278 RTP/AVP 8 101

a=sendrecv

a=rtpmap:8 PCMA/8000

a=rtpmap:101 telephone-event/8000

a=fmtp:101 0-15

a=ptime:20

005021: Aug 2 09:07:45.919: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

To: <sip:+49XXXXXXX71@telekom.de;user=phone>

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 INVITE

Allow-Events: telephone-event

Content-Length: 0

005022: Aug 2 09:07:46.177: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

To: <sip:+49XXXXXXX71@telekom.de;user=phone>;tag=60404785-1D1C

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

P-Asserted-Identity: <sip:+49XXXXXX10@93.241.231.36>

Contact: <sip:+49XXXXXXX71@93.241.231.36:5060;transport=tcp>

Record-Route: <sip:stat.sip-trunk.telekom.de;transport=tcp;lr>

Content-Length: 0

005023: Aug 2 09:07:46.540: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

To: <sip:+49XXXXXXX71@telekom.de;user=phone>;tag=60404785-1D1C

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

P-Asserted-Identity: <sip:+49XXXXXX10@93.241.231.36>

Contact: <sip:+49XXXXXXX71@93.241.231.36:5060;transport=tcp>

Record-Route: <sip:stat.sip-trunk.telekom.de;transport=tcp;lr>

Content-Length: 0

005024: Aug 2 09:07:46.930: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 180 Ringing

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

To: <sip:+49XXXXXXX71@telekom.de;user=phone>;tag=60404785-1D1C

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 INVITE

Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, UPDATE, REFER, SUBSCRIBE, NOTIFY, INFO, REGISTER

Allow-Events: telephone-event

P-Asserted-Identity: <sip:+49XXXXXX10@93.241.231.36>

Contact: <sip:+49XXXXXXX71@93.241.231.36:5060;transport=tcp>

Record-Route: <sip:stat.sip-trunk.telekom.de;transport=tcp;lr>

Content-Length: 0

005025: Aug 2 09:07:46.963: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 500 Internal Server Error

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

To: <sip:+49XXXXXXX71@telekom.de;user=phone>;tag=60404785-1D1C

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 INVITE

Allow-Events: telephone-event

Reason: Q.850;cause=16

Content-Length: 0

005026: Aug 2 09:07:47.000: //7446/E134ED29973C/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:+49XXXXXX71@tel.t-online.de:5060;transport=tcp;user=phone SIP/2.0

Via: SIP/2.0/TCP 217.0.129.100:5060;branch=z9hG4bK6aeaa39b2e79308e03d144e2aef5c447.6972df8a

Max-Forwards: 62

To: <sip:+49XXXXXXX71@telekom.de;user=phone>;tag=60404785-1D1C

From: <sip:+49XXXXXXX14@sip-trunk.telekom.de;user=phone>;tag=320109bb

Call-ID: 987c18c2009f09fd@87.137.173.231

CSeq: 50054372 ACK

Content-Length: 0

---------------

colcha · ‎09-12-2023

Additional information, the IPECS PBX is connected to a CISCO 4321 router

colcha · ‎09-12-2023

#sh running-config
Building configuration...

Current configuration : 14142 bytes
!
! Last configuration change at 10:00:24 CEST Thu Jul 27 2023 by admin
! NVRAM config last updated at 10:00:52 CEST Thu Jul 27 2023 by admin
!
version 16.9
no service pad
service timestamps debug datetime msec
service timestamps log datetime msec
service password-encryption
service sequence-numbers
platform qfp utilization monitor load 80
no platform punt-keepalive disable-kernel-core
!
hostname xxxxx21
!
boot-start-marker
boot system flash bootflash:isr4300-universalk9.16.09.04.SPA.bin
boot-end-marker
!
!
vrf definition Mgmt-intf
--More-- !
address-family ipv4
exit-address-family
!
address-family ipv6
exit-address-family
!
!
no aaa new-model
clock timezone CET 1 0
clock summer-time CEST recurring last Sun Mar 2:00 last Sun Oct 3:00
!
ip domain name lvn.it-nrw.de
!
!
!
login on-success log
!
!
!
!
!
!
--More-- !
subscriber templating
!
!
!
!
!
multilink bundle-name authenticated
!
flow record PRTG_FLOW_RECORD
description NetFlow record format to send to PRTG
match ipv4 ttl
match ipv4 tos
match ipv4 protocol
match ipv4 source address
match ipv4 destination address
match transport source-port
match transport destination-port
match interface input
collect ipv4 dscp
collect transport tcp flags
collect interface output
collect counter bytes long
--More-- collect counter packets long
collect timestamp sys-uptime first
collect timestamp sys-uptime last
!
!
flow exporter NETFLOW_TO_PRTG
description Export NetFlow to PRTG
destination xxx.xxx.xxx.xxx
source Loopback0
transport udp 9991
!
!
flow monitor IPv4_NETFLOW
exporter NETFLOW_TO_PRTG
cache timeout active 60
record PRTG_FLOW_RECORD
!
!
!
!
!
password encryption aes
isdn switch-type basic-net3
--More-- !
!
!
!
!
voice call send-alert
!
voice service voip
ip address trusted list
ipv4 217.0.0.0 255.252.0.0
ipv4 217.4.0.0 255.255.0.0
ipv4 217.5.0.0 255.255.128.0
address-hiding
no supplementary-service sip refer
fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback pass-through g711alaw
h323
call service stop forced
sip
min-se 120
registrar server expires max 600 min 60
asserted-id pai
outbound-proxy dns:stat.sip-trunk.telekom.de reuse
--More-- conn-reuse
source filter
privacy-policy passthru
sip-profiles inbound
!
voice class codec 1
codec preference 1 g711alaw
!
voice class sip-profiles 200
rule 10 request ANY sip-header Date remove
rule 20 response ANY sip-header Date remove
rule 30 request ANY sip-header User-Agent remove
rule 40 response ANY sip-header User-Agent remove
rule 50 request ANY sip-header Cisco-Guid remove
rule 60 response ANY sip-header Cisco-Guid remove
rule 70 request ANY sdp-header Session-Owner modify "CiscoSystemsSIP-GW-UserAgent" "-"
rule 80 response ANY sdp-header Session-Owner modify "CiscoSystemsSIP-GW-UserAgent" "-"
rule 90 request ANY sip-header P-Asserted-Identity modify "<sip:.*@" "<sip:+49XXXXXXX10@"
rule 100 response ANY sip-header P-Asserted-Identity modify "<sip:.*@" "<sip:+49XXXXXXX10@"
--More-- rule 110 request ANY sip-header Diversion remove
rule 120 request ANY sip-header Server remove
rule 130 response ANY sip-header Server remove
rule 140 request ANY sip-header Session-ID remove
rule 150 response ANY sip-header Session-ID remove
!
voice class sip-profiles 201
rule 10 request ANY sip-header From modify "sip:anonymous@anonymous.invalid" "sip:0000@anonymous.invalid"
rule 20 request ANY sip-header P-Asserted-Identity remove
!
voice class e164-pattern-map 200
e164 11T
e164 +T
!
!
!
!
voice register global
mode cme
source-address xxx.xxx.xxx.xxx port 5060
max-dn 10
auto-register
--More-- !
!
!
voice translation-rule 100
rule 1 /^\+49XXXXX1/ /XXX1/ type any subscriber plan any isdn
!
voice translation-rule 101
rule 1 /^\+49/ // type any national plan any isdn
rule 2 /^\+/ // type any international plan any isdn
rule 3 /^0000/ // type any unknown plan any unknown
!
voice translation-rule 110
rule 1 /^00/ /+/
rule 2 /^0/ /+49/
rule 3 /^11\([025]\)/ /11\1/
rule 4 /^116/ /116/
rule 5 /^118/ /118/
rule 6 /^/ /+49XXX1/
!
voice translation-rule 111
rule 1 /^0XXX1/ /+49XXXX1/ type subscriber unknown
rule 2 /^0/ /+49/ type national unknown
rule 3 /^0/ /+/ type international unknown
--More-- !
voice translation-rule 121
rule 1 /^/ /0/
!
!
voice translation-profile PBX-in
translate calling 111
translate called 110
!
voice translation-profile PBX-out
translate calling 101
translate called 100
!
voice translation-profile VoicePortIn
translate calling 121
!
!
!
!
voice-card 0/2
no watchdog
!
license udi pid ISR4321/K9 sn FDO2XXXXXXX
--More-- license accept end user agreement
license boot level securityk9
no license smart enable
diagnostic bootup level minimal
!
spanning-tree extend system-id
!
!
!
!
!
object-group network Telekom
xxx.xxx.xxx.xxx 255.252.0.0
xxx.xxx.xxx.xxx 255.255.0.0
xxx.xxx.xxx.xxx 255.255.128.0
!
!
!
username admin privilege 15 secret 5 xxxxxxxxxxxxxxxx
!
redundancy
mode none
!
--More-- !
!
!
controller VDSL 0/1/0
!
!
!
!
!
!
!
!
crypto isakmp policy 1
encr aes
authentication pre-share
group 5
crypto isakmp key 6 xxxxxxxxxxx address xxx.xxx.xxx.xxx
!
!
crypto ipsec transform-set cisco-xform-set esp-aes 256 esp-sha-hmac
mode tunnel
!
--More-- !
!
crypto map cisco-crypto-map 10 ipsec-isakmp
set peer xxx.xxx.xxx.xxx
set transform-set cisco-xform-set
match address 100
!
!
!
!
!
!
!
!
interface Loopback0
ip address xxx.xxx.xxx.xxx 255.255.255.255
!
interface GigabitEthernet0/0/0
no ip address
shutdown
negotiation auto
!
interface GigabitEthernet0/0/1
--More-- no ip address
shutdown
negotiation auto
!
interface ATM0/1/0
no ip address
atm oversubscribe factor 2
no atm enable-ilmi-trap
!
interface ATM0/1/0.7 point-to-point
no atm enable-ilmi-trap
pvc 1/32
bridge-dot1q encap 7
pppoe-client dial-pool-number 1
!
!
interface Ethernet0/1/0
no ip address
no negotiation auto
!
interface Service-Engine0/2/4
!
interface GigabitEthernet0
--More-- vrf forwarding Mgmt-intf
ip address xxx.xxx.xxx.xxxx 255.255.255.0
negotiation auto
!
interface BRI0/2/0:0
no ip address
isdn switch-type basic-net3
isdn overlap-receiving T302 4000
isdn protocol-emulate network
isdn layer1-emulate network
isdn incoming-voice voice
isdn sending-complete
isdn datetime message connect priority local
isdn static-tei 0
isdn skipsend-idverify
!
interface BRI0/2/1:0
no ip address
isdn switch-type basic-net3
isdn overlap-receiving T302 4000
isdn protocol-emulate network
isdn layer1-emulate network
isdn incoming-voice voice
--More-- isdn sending-complete
isdn datetime message connect priority local
isdn static-tei 0
isdn skipsend-idverify
!
interface BRI0/2/2:0
no ip address
isdn switch-type basic-net3
isdn overlap-receiving T302 4000
isdn protocol-emulate network
isdn layer1-emulate network
isdn incoming-voice voice
isdn sending-complete
isdn datetime message connect priority local
isdn static-tei 0
isdn skipsend-idverify
!
interface BRI0/2/3:0
no ip address
isdn switch-type basic-net3
isdn overlap-receiving T302 4000
isdn protocol-emulate network
isdn layer1-emulate network
--More-- isdn incoming-voice voice
isdn sending-complete
isdn datetime message connect priority local
isdn static-tei 0
isdn skipsend-idverify
!
interface Dialer0
bandwidth 25000
ip flow monitor IPv4_NETFLOW input
ip address negotiated
no ip redirects
no ip unreachables
ip access-group WAN-IN in
encapsulation ppp
ip tcp adjust-mss 1448
load-interval 30
dialer pool 1
dialer-group 1
no cdp enable
ppp chap hostname xxxxxxxxxxx@t-online.de
ppp chap password 7 xxxxxxxxxxxxxxxx
ppp ipcp dns request
ppp ipcp mask request
--More-- crypto map cisco-crypto-map
!
ip forward-protocol nd
ip ftp source-interface Loopback0
no ip http server
ip http authentication local
no ip http secure-server
ip tftp source-interface GigabitEthernet0
ip route xxx.xxx.xxx.xxx 255.255.255.255 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.0.0 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.255.255 Dialer0
ip route xxx.xxx.xxx.xxx 255.252.0.0 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.0.0 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.128.0 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.255.255 Dialer0
ip route xxx.xxx.xxx.xxx 255.255.255.255 Dialer0
!
ip ssh version 2
!
!
ip access-list extended WAN-IN
permit udp host xxx.xxx.xxx.xxx eq domain host xxx.xxx.xxx.xxx range 1024 65535
permit udp host xxx.xxx.xxx.xxx eq domain host xxx.xxx.xxx.xxx range 1024 65535
--More-- permit icmp object-group Telekom host xxx.xxx.xxx.xxx administratively-prohibited
permit icmp object-group Telekom host xxx.xxx.xxx.xxx echo-reply
permit icmp object-group Telekom host xxx.xxx.xxx.xxx unreachable
permit icmp object-group Telekom host xxx.xxx.xxx.xxx time-exceeded
permit tcp object-group Telekom host xxx.xxx.xxx.xxx eq 5060
permit tcp object-group Telekom eq 5060 host xxx.xxx.xxx.xxx range 1024 65535 established
permit udp object-group Telekom host xxx.xxx.xxx.xxx eq 5060
permit udp object-group Telekom eq 5060 host xxx.xxx.xxx.xxx range 1024 65535
permit udp object-group Telekom host xxx.xxx.xxx.xxx range 8000 48198
permit udp host xxx.xxx.xxx.xxx eq isakmp host xxx.xxx.xxx.xxx eq isakmp
permit udp host xxx.xxx.xxx.xxx eq non500-isakmp host xxx.xxx.xxx.xxx eq non500-isakmp
permit esp host xxx.xxx.xxx.xxx host xxx.xxx.xxx.xxx
ip access-list extended 100
permit ip host xxx.xxx.xxx.xxx xxx.xxx.xxx.xxx 0.0.255.255
dialer-list 1 protocol ip permit
!
!
snmp-server group xx.xxxxxxxgrp v3 auth
snmp-server location Cisco ISR4300 - xxxxxxx21
snmp-server contact XXX:de
snmp-server host xxx.xxx.xxx.xxx jz.xxxx-usr
--More-- !
!
control-plane
!
call treatment cause-code busy
call treatment isdn-reject 42
call treatment on
call threshold global cpu-avg low 80 high 85
call threshold global total-mem low 80 high 85
call spike 10 steps 3 size 110
!
voice-port 0/2/0
translation-profile incoming VoicePortIn
compand-type a-law
cptone DE
bearer-cap 3100Hz
!
voice-port 0/2/1
translation-profile incoming VoicePortIn
compand-type a-law
cptone DE
bearer-cap 3100Hz
!
--More-- voice-port 0/2/2
translation-profile incoming VoicePortIn
compand-type a-law
cptone DE
bearer-cap 3100Hz
!
voice-port 0/2/3
translation-profile incoming VoicePortIn
compand-type a-law
cptone DE
bearer-cap 3100Hz
!
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
!
!
!
!
dial-peer voice 10 pots
--More-- description PBX In with dialtone
translation-profile incoming PBX-in
answer-address .
!
dial-peer voice 11 pots
description PBX In without dialtone
translation-profile incoming PBX-in
incoming called-number .
direct-inward-dial
!
dial-peer voice 100 pots
description PBX out
translation-profile outgoing PBX-out
destination-pattern +49xxxxxxxxT
progress_ind setup enable 3
port 0/2/0
forward-digits all
!
dial-peer voice 101 pots
description PBX out
translation-profile outgoing PBX-out
preference 1
destination-pattern +49xxxxxxxxT
--More-- progress_ind setup enable 3
port 0/2/1
forward-digits all
!
dial-peer voice 102 pots
description PBX out
translation-profile outgoing PBX-out
huntstop
destination-pattern +49xxxxxxxxT
progress_ind setup enable 3
port 0/2/2
forward-digits all
!
dial-peer voice 103 pots
description PBX out
translation-profile outgoing PBX-out
destination-pattern +49xxxxxxxxT
progress_ind setup enable 3
port 0/2/3
forward-digits all
!
dial-peer voice 200 voip
description T-Online In/Out
--More-- session protocol sipv2
session target sip-server
session transport tcp
destination e164-pattern-map 200
incoming called-number .
voice-class codec 1
voice-class sip asserted-id pai
voice-class sip outbound-proxy dns:stat.sip-trunk.telekom.de
voice-class sip profiles 200
voice-class sip profiles 201 inbound
voice-class sip bind control source-interface Dialer0
voice-class sip bind media source-interface Dialer0
dtmf-relay rtp-nte
fax-relay ecm disable
fax rate disable
fax protocol none
clid strip name
no vad
!
!
sip-ua
no remote-party-id
retry invite 2
--More-- retry notify 3
timers dns registrar-cache ttl
sip-server dns:sip-trunk.telekom.de
connection-reuse
!
!
line con 0
login local
transport input none
stopbits 1
line aux 0
login local
stopbits 1
line vty 0 4
login local
transport input ssh
line vty 5 15
login local
transport input ssh
!
ntp source Loopback0
ntp server xxx.xxx.xxx.xxx
!

end

colcha · ‎09-12-2023

Hi All ,

Today I did another test.
here is the result

OARB000000#

001581: Aug 2 19:58:04.103: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: No match! number=From: <sip:+4917671234845@sip-trunk.telekom.de;user=phone>;tag=b86dedcb matchPattern=sip:anonymous@anonymous.invalid replacePattern=sip:0000@anonymous.invalid
001582: Aug 2 19:58:04.105: //-1/B9DC651B8061/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=+4917671234845
----- ccCallInfo IE subfields -----
cisco-ani=+4917671234845
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=+495971927171
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

001583: Aug 2 19:58:04.107: //-1/B9DC651B8061/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7EFDA7786828, Call Info(
Calling Number=+4917671234845,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=+495971927171(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=200, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=32
001584: Aug 2 19:58:04.107: //-1/B9DC651B8061/CCAPI/ccCheckClipClir:
In: Calling Number=+4917671234845(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
001585: Aug 2 19:58:04.107: //-1/B9DC651B8061/CCAPI/ccCheckClipClir:
Out: Calling Number=+4917671234845(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
001586: Aug 2 19:58:04.107: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001587: Aug 2 19:58:04.107: :cc_get_feature_vsa malloc success
001588: Aug 2 19:58:04.107: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001589: Aug 2 19:58:04.107: cc_get_feature_vsa count is 1
001590: Aug 2 19:58:04.107: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001591: Aug 2 19:58:04.107: :FEATURE_VSA attributes are: feature_name:0,feature_time:139627924990284,feature_id:32
001592: Aug 2 19:58:04.108: //32/B9DC651B8061/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=+4917671234845(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=+495971927171(TON=Unknown, NPI=Unknown))
001593: Aug 2 19:58:04.108: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DDAAE0; count=1
001594: Aug 2 19:58:04.108: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A4270
001595: Aug 2 19:58:04.108: //32/B9DC651B8061/CCAPI/cc_process_call_setup_ind:
Event=0x7EFDA8E0C470
001596: Aug 2 19:58:04.108: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number +495971927171
001597: Aug 2 19:58:04.109: //32/B9DC651B8061/CCAPI/ccCallSetContext:
Context=0x7EFDB3C05618
001598: Aug 2 19:58:04.109: //32/B9DC651B8061/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 32 with tag 200 to app "_ManagedAppProcess_Default"
001599: Aug 2 19:58:04.112: //-1/B9DC651B8061/RXRULE/regxrule_stack_push_RegXruleNumInfo_internal: stack=0x7EFDA0DDAAE0; count=1
001600: Aug 2 19:58:04.112: //32/B9DC651B8061/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
001601: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_translate_exist_internal: no rule for callback-number number
001602: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number=+4917671234845type=unknown plan=unknown numbertype=calling
001603: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 101
001604: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 101
001605: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/sed_subst: Successful substitution; pattern=+4917671234845matchPattern=^\+49 replacePattern= replaced pattern=17671234845
001606: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_type: Match Type = any, Replace Type = national Input Type = unknown
001607: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_plan: Match Plan = any, Replace Plan = isdn Input Plan = unknown
001608: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: xlt_number=17671234845 xlt_type=national xlt_plan=isdn
001609: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number=+495971927171type=unknown plan=unknown numbertype=called
001610: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 100
001611: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 100
001612: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/sed_subst: Successful substitution; pattern=+495971927171matchPattern=^\+4959719271replacePattern=9271 replaced pattern=927171
001613: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_type: Match Type = any, Replace Type = subscriber Input Type = unknown
001614: Aug 2 19:58:04.113: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_plan: Match Plan = any, Replace Plan = isdn Input Plan = unknown
001615: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: xlt_number=927171 xlt_type=subscriber xlt_plan=isdn
001616: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number= type=subscriber plan=isdn numbertype=redirect-target
001617: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001618: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Error: ruleset for redirect-target number not found
001619: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: No match: number= type=subscriber plan=isdn
001620: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number= type=unknown plan=unknown numbertype=redirect-called
001621: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001622: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Error: ruleset for redirect-called number not found
001623: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: No match: number= type=unknown plan=unknown
001624: Aug 2 19:58:04.114: //32/B9DC651B8061/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=103, Params=0x7EFDB3C01168, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
001625: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_vp_translate: No profile found in voice port or trunk group for outgoing direction
001626: Aug 2 19:58:04.114: //-1/B9DC651B8061/RXRULE/regxrule_vp_translate: calling_number=17671234845 calling_octet=0x21
called_number=927171 called_octet=0x41
redirect_number= redirect_type=0 redirect_plan=0
001627: Aug 2 19:58:04.114: //32/B9DC651B8061/CCAPI/ccCheckClipClir:
In: Calling Number=17671234845(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001628: Aug 2 19:58:04.114: //32/B9DC651B8061/CCAPI/ccCheckClipClir:
Out: Calling Number=17671234845(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001629: Aug 2 19:58:04.115: //32/B9DC651B8061/CCAPI/ccCallSetupRequest:
Destination Pattern=+4959719271T, Called Number=927171, Digit Strip=TRUE
001630: Aug 2 19:58:04.115: //32/B9DC651B8061/CCAPI/ccCallSetupRequest:
Calling Number=17671234845(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=927171(TON=Subscriber, NPI=ISDN),
Redirect Number=, Display Info=
Account Number=+4917671234845, Final Destination Flag=TRUE,
Guid=B9DC651B-30A5-11EE-8061-BB45810626B0, Outgoing Dial-peer=103
001631: Aug 2 19:58:04.115: //32/B9DC651B8061/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=+4917671234845
----- ccCallInfo IE subfields -----
cisco-ani=17671234845
cisco-anitype=2
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=927171
cisco-desttype=4
cisco-destplan=1
cisco-rdie=FFFFFFFFFFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=-1
cisco-rdnsi=-1
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

001632: Aug 2 19:58:04.116: //32/B9DC651B8061/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x7EFDAC469A00, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=17671234845,(Calling Name=)(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=927171(TON=Subscriber, NPI=ISDN), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=103, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
001633: Aug 2 19:58:04.116: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001634: Aug 2 19:58:04.116: :cc_get_feature_vsa malloc success
001635: Aug 2 19:58:04.116: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001636: Aug 2 19:58:04.116: cc_get_feature_vsa count is 2
001637: Aug 2 19:58:04.117: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001638: Aug 2 19:58:04.117: :FEATURE_VSA attributes are: feature_name:0,feature_time:139627924990060,feature_id:33
001639: Aug 2 19:58:04.117: //33/B9DC651B8061/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
001640: Aug 2 19:58:04.117: //33/B9DC651B8061/CCAPI/ccCallSetContext:
Context=0x7EFDB3C010E8
001641: Aug 2 19:58:04.117: //32/B9DC651B8061/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=103
001642: Aug 2 19:58:04.118: ISDN BR0/2/3:0 Q931: Applying typeplan for sw-type 0x1 is 0x2 0x1, Calling num 17671234845
001643: Aug 2 19:58:04.118: ISDN BR0/2/3:0 Q931: Sending SETUP callref = 0x000D callID = 0x800D switch = basic-net3 interface = Network
001644: Aug 2 19:58:04.119: ISDN BR0/2/3:0 Q931: TX -> SETUP pd = 8 callref = 0x0D
Bearer Capability i = 0x9090A3
Standard = CCITT
Transfer Capability = 3.1kHz Audio
Transfer Mode = Circuit
Transfer Rate = 64 kbit/s
Channel ID i = 0x89
Exclusive, B1
Progress Ind i = 0x8183 - Origination address is non-ISDN
Calling Party Number i = 0x2180, '17671234845'
Plan:ISDN, Type:National
Called Party Number i = 0xC1, '927171'
Plan:ISDN, Type:Subscriber(local)
Sending Complete

001646: Aug 2 19:58:04.184: ISDN BR0/2/3:0 Q931: RX <- CALL_PROC pd = 8 callref = 0x8D
Channel ID i = 0x89
Exclusive, B1
001647: Aug 2 19:58:04.185: //33/B9DC651B8061/CCAPI/cc_api_call_proceeding:
Interface=0x7EFDAC469A00, Progress Indication=NULL(0)
001648: Aug 2 19:58:04.360: ISDN BR0/2/0:0 Q931: RX <- SETUP pd = 8 callref = 0x04
Bearer Capability i = 0x8090A3
Standard = CCITT
Transfer Capability = Speech
Transfer Mode = Circuit
Transfer Rate = 64 kbit/s
Channel ID i = 0x89
Exclusive, B1
Calling Party Number i = 0x2180, '5971927171'
Plan:ISDN, Type:National
Redirecting Number i = '!', 0x80, '17671234845'
Plan:ISDN, Type:National
001649: Aug 2 19:58:04.360: ISDN BR0/2/0:0 Q931: extract_redirect_orig_called_ie: IE type redirecting num 17671234845 reason -1 cnt -1 plan 1 type 2 pres 0
001650: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_voiceport_internal: Found profile VoicePortIn defined on voice-port
001651: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_trunkgroup_internal:
Voice port 0x7EFDAC408C38 dsl=0 timeslot=1 does not belong to any trunk group
001652: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 121
001653: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=5971927171 matchPattern=^ replacePattern=0 replaced pattern=05971927171
001654: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_type: Match Type = none, Replace Type = none Input Type = national
001655: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001656: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001657: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for called number not found
001658: Aug 2 19:58:04.361: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_voiceport_internal: Found profile VoicePortIn defined on voice-port
001659: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 121
001660: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=5971927171 matchPattern=^ replacePattern=0 replaced pattern=05971927171
001661: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_type: Match Type = none, Replace Type = none Input Type = national
001662: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001663: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001664: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for called number not found
001665: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001666: Aug 2 19:58:04.362: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for redirect-called number not found
001667: Aug 2 19:58:04.363: ISDN BR0/2/0:0 Q931: TX -> SETUP_ACK pd = 8 callref = 0x84
Channel ID i = 0x89
Exclusive, B1
001668: Aug 2 19:58:04.364: //-1/BA039B33800E/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=05971927171
cisco-anitype=2
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=
cisco-desttype=0
cisco-destplan=0
cisco-rdie=74
cisco-rdn=17671234845
cisco-rdntype=2
cisco-rdnplan=1
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

001669: Aug 2 19:58:04.365: //-1/BA039B33800E/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7EFDAC408C38, Call Info(
Calling Number=05971927171,(Calling Name=)(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
Incoming Dial-peer=10, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
001670: Aug 2 19:58:04.365: //-1/BA039B33800E/CCAPI/ccCheckClipClir:
In: Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001671: Aug 2 19:58:04.365: //-1/BA039B33800E/CCAPI/ccCheckClipClir:
Out: Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001672: Aug 2 19:58:04.365: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001673: Aug 2 19:58:04.365: :cc_get_feature_vsa malloc success
001674: Aug 2 19:58:04.365: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001675: Aug 2 19:58:04.366: cc_get_feature_vsa count is 3
001676: Aug 2 19:58:04.366: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001677: Aug 2 19:58:04.366: :FEATURE_VSA attributes are: feature_name:0,feature_time:139627924989836,feature_id:34
001678: Aug 2 19:58:04.366: //34/BA039B33800E/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown))
001679: Aug 2 19:58:04.366: //-1/BA039B33800E/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DDCAF8; count=1
001680: Aug 2 19:58:04.366: //-1/BA039B33800E/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A6570
001681: Aug 2 19:58:04.366: //34/BA039B33800E/CCAPI/cc_process_call_setup_ind:
Event=0x7EFDA8E0C470
001682: Aug 2 19:58:04.366: //34/BA039B33800E/CCAPI/ccCallSetContext:
Context=0x7EFDB3C0B258
001683: Aug 2 19:58:04.367: //34/BA039B33800E/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 34 with tag 10 to app "_ManagedAppProcess_Default"
001684: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_stack_push_RegXruleNumInfo_internal: stack=0x7EFDA0DDCAF8; count=1
001685: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_profile_translate_internal: number=05971927171 type=national plan=isdn numbertype=calling
001686: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001687: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_profile_match_internal: Matched with rule 2 in ruleset 111
001688: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001689: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_profile_match_internal: Matched with rule 2 in ruleset 111
001690: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001691: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/sed_subst: Successful substitution; pattern=05971927171 matchPattern=^0 replacePattern=+49 replaced pattern=+495971927171
001692: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_subst_num_type: Match Type = national, Replace Type = unknown Input Type = national
001693: Aug 2 19:58:04.367: //-1/BA039B33800E/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001694: Aug 2 19:58:04.368: //-1/BA039B33800E/RXRULE/regxrule_profile_translate_internal: xlt_number=+495971927171xlt_type=unknown xlt_plan=isdn
001695: Aug 2 19:58:04.368: //-1/BA039B33800E/RXRULE/regxrule_profile_translate_internal: number=17671234845 type=national plan=isdn numbertype=redirect-called
001696: Aug 2 19:58:04.368: //-1/BA039B33800E/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001697: Aug 2 19:58:04.368: //-1/BA039B33800E/RXRULE/regxrule_profile_match_internal: Error: ruleset for redirect-called number not found
001698: Aug 2 19:58:04.368: //-1/BA039B33800E/RXRULE/regxrule_profile_translate_internal: No match: number=17671234845 type=national plan=isdn
001699: Aug 2 19:58:04.368: //34/BA039B33800E/CCAPI/ccCallSetupAck:
Call Id=34
001700: Aug 2 19:58:04.368: //34/BA039B33800E/CCAPI/cc_api_set_transfer_info:
Transfer Number=, Transfer Reason=0x0
001701: Aug 2 19:58:04.368: //34/BA039B33800E/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=TRUE, Tone=Dial Tone,
Tone Direction=Network, Params=0x0, Call Id=34
001702: Aug 2 19:58:04.372: //34/BA039B33800E/CCAPI/ccSetDigitTimeouts:
Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
001703: Aug 2 19:58:04.372: //34/BA039B33800E/CCAPI/ccSetDigitTimeouts:
Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
001704: Aug 2 19:58:04.372: //34/BA039B33800E/CCAPI/ccCallReportDigits:
(callID=0x22, digit_event=0x1, enable=TRUE, consume=FALSE)
001705: Aug 2 19:58:04.373: //34/BA039B33800E/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=34
001706: Aug 2 19:58:04.373: //34/BA039B33800E/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x7EFDAC408C38, callID=0x22, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
001707: Aug 2 19:58:04.373: //34/BA039B33800E/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x7EFDAC408C38, Call Id=34
001708: Aug 2 19:58:04.373: //34/BA039B33800E/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
001709: Aug 2 19:58:04.415: ISDN BR0/2/0:0 Q931: RX <- DISCONNECT pd = 8 callref = 0x04
Cause i = 0x8090 - Normal call clearing
001710: Aug 2 19:58:04.416: ISDN BR0/2/0:0 Q931: TX -> RELEASE pd = 8 callref = 0x84
Cause i = 0x8290 - Normal call clearing
001711: Aug 2 19:58:04.416: //34/BA039B33800E/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x7EFDAC408C38, Call Id=34
001712: Aug 2 19:58:04.416: //34/BA039B33800E/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
001713: Aug 2 19:58:04.417: //34/BA039B33800E/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
001714: Aug 2 19:58:04.417: //34/BA039B33800E/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
001715: Aug 2 19:58:04.417: //34/BA039B33800E/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
001716: Aug 2 19:58:04.456: ISDN BR0/2/0:0 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x04
Cause i = 0x8290 - Normal call clearing
001717: Aug 2 19:58:04.459: //34/BA039B33800E/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7EFDAC408C38, Tag=0x0, Call Id=34,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
001718: Aug 2 19:58:04.459: //-1/BA039B33800E/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DDCAF8; count=1
001719: Aug 2 19:58:04.459: //-1/BA039B33800E/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A6570
001720: Aug 2 19:58:04.459: //34/BA039B33800E/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
001721: Aug 2 19:58:04.459: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001722: Aug 2 19:58:04.459: :cc_free_feature_vsa freeing 7EFDA8DEA780
001723: Aug 2 19:58:04.459: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001724: Aug 2 19:58:04.459: vsacount in free is 2
001725: Aug 2 19:58:04.484: ISDN BR0/2/3:0 Q931: RX <- ALERTING pd = 8 callref = 0x8D
Channel ID i = 0x89
Exclusive, B1
001726: Aug 2 19:58:04.485: //33/B9DC651B8061/CCAPI/cc_api_call_alert:
Interface=0x7EFDAC469A00, Progress Indication=NULL(0), Signal Indication=NOT PRESENT(255)
001727: Aug 2 19:58:04.485: //33/B9DC651B8061/CCAPI/cc_api_call_alert:
Call Entry(Retry Count=0, Responsed=TRUE)
001728: Aug 2 19:58:04.485: //32/B9DC651B8061/CCAPI/ccCallAlert:
Progress Indication=NULL(0), Signal Indication=NOT PRESENT(255)
001729: Aug 2 19:58:04.485: //32/B9DC651B8061/CCAPI/ccCallAlert:
Call Entry(Responsed=TRUE, Alert Sent=TRUE)
001730: Aug 2 19:58:04.486: //32/B9DC651B8061/CCAPI/ccCallNotify:
Data Bitmask=0x7, Call Id=32
001731: Aug 2 19:58:04.486: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=P-Asserted-Identity: <sip:927171@93.241.231.36> matchPattern=<sip:.*@ replacePattern=<sip:+49597192710@ replaced pattern=P-Asserted-Identity: <sip:+49597192710@93.241.231.36>
001732: Aug 2 19:58:04.487: //32/B9DC651B8061/SIP/Msg/ccsipDisplayMsg:

001733: Aug 2 19:58:04.515: ISDN BR0/2/3:0 Q931: RX <- DISCONNECT pd = 8 callref = 0x8D
Cause i = 0x8090 - Normal call clearing
001734: Aug 2 19:58:04.515: ISDN BR0/2/3:0 Q931: TX -> RELEASE pd = 8 callref = 0x0D
Cause i = 0x8290 - Normal call clearing
001735: Aug 2 19:58:04.516: //33/B9DC651B8061/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x7EFDAC469A00, Call Id=33
001736: Aug 2 19:58:04.516: //33/B9DC651B8061/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
001737: Aug 2 19:58:04.517: //32/B9DC651B8061/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
001738: Aug 2 19:58:04.517: //33/B9DC651B8061/CCAPI/ccCallSetAAA_Accounting:
Accounting=1, Call Id=33
001739: Aug 2 19:58:04.517: //33/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
001740: Aug 2 19:58:04.517: //33/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
001741: Aug 2 19:58:04.517: //33/B9DC651B8061/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
001742: Aug 2 19:58:04.519: //33/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7EFDAC469A00, Tag=0x0, Call Id=33,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
001743: Aug 2 19:58:04.519: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x0
001744: Aug 2 19:58:04.519: //33/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
001745: Aug 2 19:58:04.519: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001746: Aug 2 19:58:04.519: :cc_free_feature_vsa freeing 7EFDA8DEA860
001747: Aug 2 19:58:04.520: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001748: Aug 2 19:58:04.520: vsacount in free is 1
001749: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_translate_exist_internal: no rule for callback-number number
001750: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number=+4917671234845type=unknown plan=unknown numbertype=calling
001751: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 101
001752: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 101
001753: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/sed_subst: Successful substitution; pattern=+4917671234845matchPattern=^\+49 replacePattern= replaced pattern=17671234845
001754: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_type: Match Type = any, Replace Type = national Input Type = unknown
001755: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_plan: Match Plan = any, Replace Plan = isdn Input Plan = unknown
001756: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: xlt_number=17671234845 xlt_type=national xlt_plan=isdn
001757: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number=+495971927171type=unknown plan=unknown numbertype=called
001758: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 100
001759: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 100
001760: Aug 2 19:58:04.520: //-1/B9DC651B8061/RXRULE/sed_subst: Successful substitution; pattern=+495971927171matchPattern=^\+4959719271replacePattern=9271 replaced pattern=927171
001761: Aug 2 19:58:04.521: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_type: Match Type = any, Replace Type = subscriber Input Type = unknown
001762: Aug 2 19:58:04.521: //-1/B9DC651B8061/RXRULE/regxrule_subst_num_plan: Match Plan = any, Replace Plan = isdn Input Plan = unknown
001763: Aug 2 19:58:04.521: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: xlt_number=927171 xlt_type=subscriber xlt_plan=isdn
001764: Aug 2 19:58:04.521: //-1/B9DC651B8061/RXRULE/regxrule_profile_translate_internal: number= type=subscriber plan=isdn numbertype=redirect-target
001796: Aug 2 19:58:04.575: ISDN BR0/2/3:0 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x8D
Cause i = 0x8290 - Normal call clearing
001797: Aug 2 19:58:04.575: ISDN BR0/2/3:0 **ERROR**: CCBRI_Go: NO CCB Src->L3 call id 0x800D, event 0x99 ces 1
001798: Aug 2 19:58:04.604: ISDN BR0/2/2:0 Q931: RX <- CALL_PROC pd = 8 callref = 0x8E
Channel ID i = 0x89
Exclusive, B1
001799: Aug 2 19:58:04.605: //35/B9DC651B8061/CCAPI/cc_api_call_proceeding:
Interface=0x7EFDAC4482B8, Progress Indication=NULL(0)
001800: Aug 2 19:58:04.757: ISDN BR0/2/0:0 Q931: RX <- SETUP pd = 8 callref = 0x04
Bearer Capability i = 0x8090A3
Standard = CCITT
Transfer Capability = Speech
Transfer Mode = Circuit
Transfer Rate = 64 kbit/s
Channel ID i = 0x89
Exclusive, B1
Calling Party Number i = 0x2180, '5971927171'
Plan:ISDN, Type:National
Redirecting Number i = '!', 0x80, '17671234845'
Plan:ISDN, Type:National
001801: Aug 2 19:58:04.758: ISDN BR0/2/0:0 Q931: extract_redirect_orig_called_ie: IE type redirecting num 17671234845 reason -1 cnt -1 plan 1 type 2 pres 0
001802: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_voiceport_internal: Found profile VoicePortIn defined on voice-port
001803: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_trunkgroup_internal:
Voice port 0x7EFDAC408C38 dsl=0 timeslot=1 does not belong to any trunk group
001804: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 121
001805: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=5971927171 matchPattern=^ replacePattern=0 replaced pattern=05971927171
001806: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_type: Match Type = none, Replace Type = none Input Type = national
001807: Aug 2 19:58:04.758: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001808: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001809: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for called number not found
001810: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_profile_from_voiceport_internal: Found profile VoicePortIn defined on voice-port
001811: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_match_internal: Matched with rule 1 in ruleset 121
001812: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=5971927171 matchPattern=^ replacePattern=0 replaced pattern=05971927171
001813: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_type: Match Type = none, Replace Type = none Input Type = national
001814: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001815: Aug 2 19:58:04.759: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001816: Aug 2 19:58:04.760: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for called number not found
001817: Aug 2 19:58:04.760: //-1/xxxxxxxxxxxx/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001818: Aug 2 19:58:04.760: //-1/xxxxxxxxxxxx/RXRULE/regxrule_profile_subst_internal: Error: ruleset for redirect-called number not found
001819: Aug 2 19:58:04.760: ISDN BR0/2/0:0 Q931: TX -> SETUP_ACK pd = 8 callref = 0x84
Channel ID i = 0x89
Exclusive, B1
001820: Aug 2 19:58:04.761: //-1/BA4055AC800F/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=05971927171
cisco-anitype=2
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=
cisco-desttype=0
cisco-destplan=0
cisco-rdie=74
cisco-rdn=17671234845
cisco-rdntype=2
cisco-rdnplan=1
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=-1 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0

001821: Aug 2 19:58:04.763: //-1/BA4055AC800F/CCAPI/cc_api_call_setup_ind_common:
Interface=0x7EFDAC408C38, Call Info(
Calling Number=05971927171,(Calling Name=)(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
Incoming Dial-peer=10, Progress Indication=NULL(0), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
001822: Aug 2 19:58:04.763: //-1/BA4055AC800F/CCAPI/ccCheckClipClir:
In: Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001823: Aug 2 19:58:04.763: //-1/BA4055AC800F/CCAPI/ccCheckClipClir:
Out: Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
001824: Aug 2 19:58:04.763: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001825: Aug 2 19:58:04.763: :cc_get_feature_vsa malloc success
001826: Aug 2 19:58:04.763: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001827: Aug 2 19:58:04.763: cc_get_feature_vsa count is 3
001828: Aug 2 19:58:04.763: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

001829: Aug 2 19:58:04.763: :FEATURE_VSA attributes are: feature_name:0,feature_time:139627924989836,feature_id:36
001830: Aug 2 19:58:04.764: //36/BA4055AC800F/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=05971927171(TON=National, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown))
001831: Aug 2 19:58:04.764: //-1/BA4055AC800F/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DD9F18; count=1
001832: Aug 2 19:58:04.764: //-1/BA4055AC800F/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A5C10
001833: Aug 2 19:58:04.764: //36/BA4055AC800F/CCAPI/cc_process_call_setup_ind:
Event=0x7EFDA8E0C470
001834: Aug 2 19:58:04.764: //36/BA4055AC800F/CCAPI/ccCallSetContext:
Context=0x7EFDB3C0C968
001835: Aug 2 19:58:04.764: //36/BA4055AC800F/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 36 with tag 10 to app "_ManagedAppProcess_Default"
001836: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_stack_push_RegXruleNumInfo_internal: stack=0x7EFDA0DD9F18; count=1
001837: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_profile_translate_internal: number=05971927171 type=national plan=isdn numbertype=calling
001838: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001839: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_profile_match_internal: Matched with rule 2 in ruleset 111
001840: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001841: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_profile_match_internal: Matched with rule 2 in ruleset 111
001842: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_match: No match; number=05971927171 rule precedence=1
001843: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/sed_subst: Successful substitution; pattern=05971927171 matchPattern=^0 replacePattern=+49 replaced pattern=+495971927171
001844: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_subst_num_type: Match Type = national, Replace Type = unknown Input Type = national
001845: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_subst_num_plan: Match Plan = none, Replace Plan = none Input Plan = isdn
001846: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_profile_translate_internal: xlt_number=+495971927171xlt_type=unknown xlt_plan=isdn
001847: Aug 2 19:58:04.765: //-1/BA4055AC800F/RXRULE/regxrule_profile_translate_internal: number=17671234845 type=national plan=isdn numbertype=redirect-called
001848: Aug 2 19:58:04.766: //-1/BA4055AC800F/RXRULE/regxrule_get_RegXrule: Invalid translation ruleset tag=0
001849: Aug 2 19:58:04.766: //-1/BA4055AC800F/RXRULE/regxrule_profile_match_internal: Error: ruleset for redirect-called number not found
001850: Aug 2 19:58:04.766: //-1/BA4055AC800F/RXRULE/regxrule_profile_translate_internal: No match: number=17671234845 type=national plan=isdn
001851: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/ccCallSetupAck:
Call Id=36
001852: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/cc_api_set_transfer_info:
Transfer Number=, Transfer Reason=0x0
001853: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=TRUE, Tone=Dial Tone,
Tone Direction=Network, Params=0x0, Call Id=36
001854: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/ccSetDigitTimeouts:
Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
001855: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/ccSetDigitTimeouts:
Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
001856: Aug 2 19:58:04.766: //36/BA4055AC800F/CCAPI/ccCallReportDigits:
(callID=0x24, digit_event=0x1, enable=TRUE, consume=FALSE)
001857: Aug 2 19:58:04.767: //36/BA4055AC800F/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=36
001858: Aug 2 19:58:04.767: //36/BA4055AC800F/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x7EFDAC408C38, callID=0x24, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
001859: Aug 2 19:58:04.767: //36/BA4055AC800F/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x7EFDAC408C38, Call Id=36
001860: Aug 2 19:58:04.767: //36/BA4055AC800F/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
001861: Aug 2 19:58:04.818: ISDN BR0/2/0:0 Q931: RX <- DISCONNECT pd = 8 callref = 0x04
Cause i = 0x8090 - Normal call clearing
001862: Aug 2 19:58:04.819: ISDN BR0/2/0:0 Q931: TX -> RELEASE pd = 8 callref = 0x84
Cause i = 0x8290 - Normal call clearing
001863: Aug 2 19:58:04.819: //36/BA4055AC800F/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x7EFDAC408C38, Call Id=36
001864: Aug 2 19:58:04.820: //36/BA4055AC800F/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
001865: Aug 2 19:58:04.820: //36/BA4055AC800F/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
001866: Aug 2 19:58:04.820: //36/BA4055AC800F/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
001867: Aug 2 19:58:04.820: //36/BA4055AC800F/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
001868: Aug 2 19:58:04.855: ISDN BR0/2/0:0 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x04
Cause i = 0x8290 - Normal call clearing
001869: Aug 2 19:58:04.858: //36/BA4055AC800F/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7EFDAC408C38, Tag=0x0, Call Id=36,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
001870: Aug 2 19:58:04.858: //-1/BA4055AC800F/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DD9F18; count=1
001871: Aug 2 19:58:04.858: //-1/BA4055AC800F/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A5C10
001872: Aug 2 19:58:04.858: //36/BA4055AC800F/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
001873: Aug 2 19:58:04.858: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001874: Aug 2 19:58:04.859: :cc_free_feature_vsa freeing 7EFDA8DEA780
001875: Aug 2 19:58:04.859: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001876: Aug 2 19:58:04.859: vsacount in free is 2
001877: Aug 2 19:58:04.874: ISDN BR0/2/2:0 Q931: RX <- ALERTING pd = 8 callref = 0x8E
Channel ID i = 0x89
Exclusive, B1
001878: Aug 2 19:58:04.875: //35/B9DC651B8061/CCAPI/cc_api_call_alert:
Interface=0x7EFDAC4482B8, Progress Indication=NULL(0), Signal Indication=NOT PRESENT(255)
001879: Aug 2 19:58:04.875: //35/B9DC651B8061/CCAPI/cc_api_call_alert:
Call Entry(Retry Count=0, Responsed=TRUE)
001880: Aug 2 19:58:04.875: //32/B9DC651B8061/CCAPI/ccCallAlert:
Progress Indication=NULL(0), Signal Indication=NOT PRESENT(255)
001881: Aug 2 19:58:04.875: //32/B9DC651B8061/CCAPI/ccCallAlert:
Call Entry(Responsed=TRUE, Alert Sent=TRUE)
001882: Aug 2 19:58:04.875: //32/B9DC651B8061/CCAPI/ccCallNotify:
Data Bitmask=0x7, Call Id=32
001883: Aug 2 19:58:04.876: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: Successful substitution; pattern=P-Asserted-Identity: <sip:927171@93.241.231.36> matchPattern=<sip:.*@ replacePattern=<sip:+49597192710@ replaced pattern=P-Asserted-Identity: <sip:+49597192710@93.241.231.36>
001884: Aug 2 19:58:04.877: //32/B9DC651B8061/SIP/Msg/ccsipDisplayMsg:

001885: Aug 2 19:58:04.905: ISDN BR0/2/2:0 Q931: RX <- DISCONNECT pd = 8 callref = 0x8E
Cause i = 0x8090 - Normal call clearing
001886: Aug 2 19:58:04.905: ISDN BR0/2/2:0 Q931: TX -> RELEASE pd = 8 callref = 0x0E
Cause i = 0x8290 - Normal call clearing
001887: Aug 2 19:58:04.906: //35/B9DC651B8061/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x7EFDAC4482B8, Call Id=35
001888: Aug 2 19:58:04.906: //35/B9DC651B8061/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
001889: Aug 2 19:58:04.907: //32/B9DC651B8061/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
001890: Aug 2 19:58:04.907: //35/B9DC651B8061/CCAPI/ccCallSetAAA_Accounting:
Accounting=0, Call Id=35
001891: Aug 2 19:58:04.907: //35/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
001892: Aug 2 19:58:04.907: //35/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
001893: Aug 2 19:58:04.907: //35/B9DC651B8061/CCAPI/cc_api_get_transfer_info:
Transfer Number=NULL
001894: Aug 2 19:58:04.909: //35/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7EFDAC4482B8, Tag=0x0, Call Id=35,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
001895: Aug 2 19:58:04.909: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x0
001896: Aug 2 19:58:04.909: //35/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
001897: Aug 2 19:58:04.909: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001898: Aug 2 19:58:04.909: :cc_free_feature_vsa freeing 7EFDA8DEA860
001899: Aug 2 19:58:04.909: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001900: Aug 2 19:58:04.909: vsacount in free is 1
001901: Aug 2 19:58:04.910: //32/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
001902: Aug 2 19:58:04.910: //32/B9DC651B8061/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
001903: Aug 2 19:58:04.911: //32/B9DC651B8061/SIP/Msg/ccsipDisplayMsg:

001904: Aug 2 19:58:04.944: //32/B9DC651B8061/SIP/Msg/ccsipDisplayMsg:

001905: Aug 2 19:58:04.945: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: No match! number=From: <sip:+4917671234845@sip-trunk.telekom.de;user=phone>;tag=b86dedcb matchPattern=sip:anonymous@anonymous.invalid replacePattern=sip:0000@anonymous.invalid
001906: Aug 2 19:58:04.945: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:

001907: Aug 2 19:58:04.965: ISDN BR0/2/2:0 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x8E
Cause i = 0x8290 - Normal call clearing
001908: Aug 2 19:58:04.966: ISDN BR0/2/2:0 **ERROR**: CCBRI_Go: NO CCB Src->L3 call id 0x800E, event 0x99 ces 1
001909: Aug 2 19:58:04.969: //32/B9DC651B8061/SIP/Msg/ccsipDisplayMsg:

001910: Aug 2 19:58:04.969: //-1/xxxxxxxxxxxx/RXRULE/sed_subst: No match! number=From: <sip:+4917671234845@sip-trunk.telekom.de;user=phone>;tag=b86dedcb matchPattern=sip:anonymous@anonymous.invalid replacePattern=sip:0000@anonymous.invalid
001911: Aug 2 19:58:04.970: //32/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x7EFDA7786828, Tag=0x0, Call Id=32,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
001912: Aug 2 19:58:04.970: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_RegXruleNumInfo: stack=0x7EFDA0DDAAE0; count=1
001913: Aug 2 19:58:04.970: //-1/B9DC651B8061/RXRULE/regxrule_stack_pop_callinfo_internal: numinfo=0x7EFDB27A62F0
001914: Aug 2 19:58:04.970: //32/B9DC651B8061/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
001915: Aug 2 19:58:04.971: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001916: Aug 2 19:58:04.971: :cc_free_feature_vsa freeing 7EFDA8DEA940
001917: Aug 2 19:58:04.971: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

001918: Aug 2 19:58:04.971: vsacount in free is 0
OAR000000#
I hope you can help me finding an answer, router or provider problem

BR ,

Colcha

b.winter · ‎09-12-2023

First of all: Do not put the debug outputs and config directly into the message body. This makes the whole thread completely unreadable.
Put them in a txt file and attach the file to the post.

Second:
If I understand correctly, you have a SIP Trunk towards the provider and a SIP trunk to the PBX. If yes, where in the debug output is the SIP part between the router and the PBX?

And where is the "outgoing" call part, that should call the external mobile number?
I assume a call flow like this:
PSTN --> CUBE --> PBX --> forwards to external number --> CUBE --> PSTN
But only the first part "PSTN --> CUBE" is visible in the debug.

And it's very clear, that you get a 500 server error, because the CUBE probably doesn't get a "200 OK" message from the PBX and therefore disconnects the call after a fixed timer.

colcha · ‎09-18-2023

Hi @b.winter

thanks for your prompt response .

That's how I'll do it next time

-----

Second:
If I understand correctly, you have a SIP Trunk towards the provider and a SIP trunk to the PBX. If yes, where in the debug output is the SIP part between the router and the PBX?

Answer : No

(SIP) (PRI)

PSTN --> GW Cisco --> PBX --> forwards to external number --> GW Cisco--> PSTN

-------------------------------

(PRI) (SIP)

PBX --> GW Cisco --> PSTN

-------------------------------

colcha · ‎09-18-2023

I add File with trace

BR ,

colcha · ‎09-18-2023

file