call-forward night-service

Voice su IP

Moderatore: Federico.Lagni

Rispondi
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Buonasera ragazzi potreste darmi una mano con questo servizio? Non riesco a farlo funzionare quando si attiva il servizio notte la chiamata non va a buon fine chiamando con un cellulare mi dice "Errore di chiamata". Ecco una parte della configurazione:


ephone-dn 1 dual-line
number 288 no-reg primary
label XXXXXXXXXX
description XXXXXXXXXX
allow watch
call-forward night-service 202
night-service bell


telephony-service
video
maximum bit-rate 256
load 7914 S00105000200
load 7941 SCCP41.8-2-2SR1S
load 7961 SCCP41.8-2-2SR1S
load 7970 SCCP70.8-2-2SR1S
max-ephones 5
max-dn 100
ip source-address 172.16.43.254 port 2000
auto assign 1 to 5
service phone displayIdleTimeout 00:10
service phone daysDisplayNotActive 1,2,3,4,5,6,7
service phone displayOnWhenIncomingCall 1
service phone videoCapability 1
timeouts interdigit 3
system message Luca Spagnoli
user-locale IT
network-locale IT
time-zone 23
time-format 24
date-format dd-mm-yy
max-conferences 2 gain -6
call-forward pattern .T
call-forward system redirecting-expanded
dn-webedit
time-webedit
transfer-system full-consult
transfer-pattern .T
night-service code *1234
night-service everyday 20:00 08:00
fac custom callfwd all 0*
create cnf-files version-stamp 7960 Sep 26 2010 18:02:33


voice register global
mode cme
source-address 172.16.43.254 port 5060
max-dn 10
max-pool 20
call-forward system redirecting-expanded
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

il problema lo hai solo se chiami via cellulare ? se chiami da rete fissa funziona ?

Ciao Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Ciao Giulio, si il problema si presenta anche se si chiama da rete fissa :(
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao Luca,

chiaremente ancheper chiamate interne ?

Metti in debug una chiamata al servizio notte e posta i log che ci diamo un occhiata.

Ciao Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Grazie mille Giulio per il tuo aiuto, guarda ti posto anche la configurazione magari ti può essere di aiuto:

Using 9112 out of 29688 bytes
!
! Last configuration change at 20:52:50 CEST Tue Sep 28 2010 by lucaspag
! NVRAM config last updated at 20:52:56 CEST Tue Sep 28 2010 by lucaspag
!
version 12.4
service timestamps debug datetime msec
service timestamps log uptime
service password-encryption
!
hostname Super4Mega-EuteliaVoip
!
boot-start-marker
boot-end-marker
!
enable password 7 030D5F0A
!
no aaa new-model
memory-size iomem 15
clock timezone CET 1
clock summer-time CEST recurring last Sun Mar 2:00 last Sun Oct 3:00
voice-card 2
!
ip cef
!
!
no ip dhcp use vrf connected
!
ip dhcp pool APPLE_AIRPORT
network 172.31.43.0 255.255.255.0
default-router 172.31.43.254
dns-server 151.99.125.1 151.99.0.100 8.8.8.8 8.8.4.4
!
ip dhcp pool iMac_G5
host 172.31.43.1 255.255.255.0
client-identifier 0100.1124.badb.2b
!
ip dhcp pool iMac_G4
host 172.31.43.2 255.255.255.0
client-identifier 0100.16cb.f294.a8
!
ip dhcp pool iBook_G4
host 172.31.43.3 255.255.255.0
client-identifier 0100.0a95.f532.d0
!
ip dhcp pool AirPort_Via_Agnone_Studio
host 172.31.43.252 255.255.255.0
client-identifier 0100.0d93.018f.79
!
ip dhcp pool AirPort_Via_Agnone_DreamBox
host 172.31.43.251 255.255.255.0
client-identifier 0100.1e52.f5f9.35
!
ip dhcp pool AirPort_Via_Agnone_Soggiorno
host 172.31.43.253 255.255.255.0
client-identifier 0100.0393.e562.8f
!
ip dhcp pool AppleTV
host 172.31.43.5 255.255.255.0
client-identifier 0100.19e3.0cd3.42
!
ip dhcp pool MacBook
host 172.31.43.6 255.255.255.0
client-identifier 0100.236c.87e2.c6
!
ip dhcp pool WIRELESS
default-router 172.31.43.254
dns-server 151.99.125.1 151.99.0.100 8.8.8.8 8.8.4.4
!
ip dhcp pool iPad
host 172.31.43.7 255.255.255.0
client-identifier 01d8.3062.9315.da
!
ip dhcp pool Cisco_IP_Phone
network 172.16.43.0 255.255.255.0
default-router 172.16.43.254
option 150 ip 172.16.43.254
dns-server 151.99.125.1 151.99.0.100 62.94.0.42 62.94.0.41
domain-name voip.eutelia.it
!
ip dhcp pool iPhone2G
host 172.31.43.4 255.255.255.0
client-identifier 0100.1ec2.ed83.4f
!
ip dhcp pool iPhone4
host 172.31.43.8 255.255.255.0
client-identifier 017c.c537.cee9.72
!
!
ip vrf forwarding
!
!
multilink bundle-name authenticated
!
!
!
voice service pots
!
voice service voip
allow-connections h323 to h323
allow-connections h323 to sip
allow-connections sip to h323
allow-connections sip to sip
supplementary-service h450.12
h323
call start slow
sip
registrar server expires max 3600 min 180
localhost dns:voip.eutelia.it
outbound-proxy ipv4:83.211.227.21
!
!
voice class codec 1
codec preference 1 g711alaw
codec preference 2 g711ulaw
codec preference 3 g729r8
!
!
!
!
!
!
!
voice register global
mode cme
source-address 172.16.43.254 port 5060
max-dn 10
max-pool 20
call-forward system redirecting-expanded
!
voice register dn 1
number 201
allow watch
name Studio
!
voice register dn 2
number 202
allow watch
name Camera
!
voice register dn 3
number 203
allow watch
name Salotto
!
voice register pool 1
id mac 001B.D45F.E2A0
number 1 dn 1
codec g711ulaw
!
voice register pool 2
id mac 001E.136C.4F53
number 2 dn 2
codec g711ulaw
!
voice register pool 3
id mac 001E.BE91.9669
number 3 dn 3
codec g711ulaw
!
!
voice translation-rule 1
rule 1 /2../ /XXXXXXXX288/
!
voice translation-rule 2
rule 1 /XXXXXXXX288/ /288/
!
!
voice translation-profile in-Sip
translate called 2
!
voice translation-profile out-SipTrunk
translate calling 1
!
!
!
!
!
!
username lucaspag password 7 08245E400C0A1118
archive
log config
hidekeys
!
!
!
!
!
class-map match-any voice-signaling
!
!
policy-map QoS
!
!
!
!
!
interface ATM0/0
no ip address
no ip mroute-cache
no atm ilmi-keepalive
dsl operating-mode auto
hold-queue 224 in
pvc 8/35
encapsulation aal5snap
protocol ppp dialer
dialer pool-member 1
!
!
interface FastEthernet0/0
ip address 172.31.43.254 255.255.255.0
ip nat inside
ip virtual-reassembly
no ip route-cache cef
no ip route-cache
no ip mroute-cache
speed auto
pppoe enable group global
pppoe-client dial-pool-number 1
!
interface FastEthernet1/1
description Siemens C450IP
!
interface FastEthernet1/2
description Cisco IP Phone 7961G Salotto
!
interface FastEthernet1/3
description Cisco IP Phone 7941G Camera
!
interface FastEthernet1/4
description Cisco IP Phone 7970G Studio
!
interface Vlan1
ip address 172.16.43.254 255.255.255.0
ip nat inside
ip nat enable
ip virtual-reassembly
!
interface Dialer0
ip address negotiated
ip nat outside
ip virtual-reassembly
encapsulation ppp
dialer pool 1
dialer-group 1
ppp pap sent-username [email protected] password 7 120B0A0F080D0E
!
ip forward-protocol nd
ip route 0.0.0.0 0.0.0.0 Dialer0
!
!
no ip http server
no ip http secure-server
ip nat inside source list 101 interface Dialer0 overload
ip nat inside source list 102 interface Dialer0 overload
ip nat inside source static udp 172.16.43.254 5060 interface Dialer0 5060
ip nat inside source static tcp 172.31.43.13 8080 XXXXXXXXXX 8080 extendable
!
access-list 101 permit ip 172.31.43.0 0.0.0.255 any
access-list 102 permit ip 172.16.43.0 0.0.0.255 any
dialer-list 1 protocol ip permit
!
!
!
!
control-plane host
!
!
control-plane
!
!
!
voice-port 2/0
operation 4-wire
echo-cancel coverage 32
no vad
playout-delay mode fixed
cptone IT
timeouts initial 120
timeouts interdigit 3
timeouts call-disconnect 0
bearer-cap Speech
!
voice-port 2/1
auto-cut-through
operation 4-wire
signal immediate
description Musica di Attesa iPod
!
!
!
!
!
!
dial-peer voice 1 pots
answer-address 2..
destination-pattern XXXXXXXX288
port 2/0
forward-digits all
authentication username XXXXXXXX288 password 7 0837454F0E170A19175F5F realm voip.eutelia.it
supported-language it
!
dial-peer voice 2 pots
port 2/1
supported-language it
!
dial-peer voice 3 voip
translation-profile incoming in-Sip
translation-profile outgoing out-SipTrunk
destination-pattern .T
voice-class codec 1
session protocol sipv2
session target sip-server
session transport udp
dtmf-relay rtp-nte
no vad
!
dial-peer voice 7777 pots
destination-pattern 7777
port 2/1
no sip-register
!
gateway
timer receive-rtp 1200
!
sip-ua
credentials username XXXXXXXX288 password 095A47081E0B181C0E5857 realm voip.eutelia.it
no remote-party-id
retry invite 4
retry response 3
retry bye 2
retry cancel 2
registrar dns:voip.eutelia.it:5060 expires 600
sip-server dns:voip.eutelia.it:5060
host-registrar
!
!
telephony-service
video
maximum bit-rate 256
load 7914 S00105000200
load 7941 SCCP41.8-2-2SR1S
load 7961 SCCP41.8-2-2SR1S
load 7970 SCCP70.8-2-2SR1S
max-ephones 5
max-dn 100
ip source-address 172.16.43.254 port 2000
auto assign 1 to 5
service phone displayIdleTimeout 00:10
service phone daysDisplayNotActive 1,2,3,4,5,6,7
service phone displayOnWhenIncomingCall 1
service phone videoCapability 1
timeouts interdigit 3
system message Luca Spagnoli
user-locale IT
network-locale IT
time-zone 23
time-format 24
date-format dd-mm-yy
max-conferences 2 gain -6
call-forward pattern .T
call-forward system redirecting-expanded
dn-webedit
time-webedit
transfer-system full-consult
transfer-pattern .T
night-service code *1234
night-service everyday 22:00 08:00
fac custom callfwd all 0*
create cnf-files version-stamp 7960 Sep 28 2010 19:10:02
!
!
ephone-template 1
service phone daysDisplayNotActive 1,2,3,4,5,6,7
service phone backlightIdleTimeout 00.10
service phone displayOnWhenIncomingCall 1
!
!
ephone-dn 1 dual-line
number 288 no-reg primary
pickup-group 200
label XXXXXX7225
description Via Agnone
allow watch
call-forward night-service 202
call-forward noan 205 timeout 15
night-service bell
!
!
ephone-dn 2 dual-line
!
!
ephone-dn 3
number 201 no-reg primary
name Studio
intercom 202 no-auto-answer label "Camera"
!
!
ephone-dn 4
number 201 no-reg primary
name Studio
intercom 203 no-auto-answer label "Salotto"
!
!
ephone-dn 5
number 203 no-reg primary
name Salotto
intercom 201 no-auto-answer label "Studio"
!
!
ephone-dn 6
number 203 no-reg primary
name Salotto
intercom 202 no-auto-answer label "Camera"
!
!
ephone-dn 7 dual-line
!
!
ephone-dn 8 dual-line
number 202 no-reg primary
pickup-group 200
label Servizio Notte
description Via Agnone
name Camera
allow watch
huntstop channel
!
!
ephone-dn 9 dual-line
number 205 no-reg primary
label Trasferimento di Chiamata
name Camera
allow watch
call-forward all 338XXXXXXX
!
!
ephone-dn 55
number 5555 no-reg primary
moh out-call 7777
!
!
ephone 1
description Cisco IP Phone 7970G Studio
video
mac-address 001B.D45F.E2A0
ephone-template 1
type 7970
auto-line 1
button 1:1 2:3 3:4
!
!
!
ephone 2
description Cisco IP Phone 7941G Camera
video
mac-address 001E.136C.4F53
type 7941
auto-line 1
button 1:8 2:9
!
!
!
ephone 3
description Cisco IP Phone 7961G Salotto
video
mac-address 001E.BE91.9669
type 7961 addon 1 7914
auto-line 1
button 1:1 2:6 3:5
!
!
!
line con 0
line aux 0
line vty 0 4
login local
!
sntp server 193.204.114.232
end

Come vedi ho anche aggiunto call-forward noan 205 timeout 15 che chiaramente non funziona come il call-forward night-service. Ed ecco il debug del servizio notte:

Sep 29 12:39:43.474: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:[email protected]:53392 SIP/2.0
Record-Route: <sip:83.211.227.21;lr=on;ftag=F34CBECC-0>
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK6cff.bcc656b1.0
Via: SIP/2.0/UDP 195.62.226.4:5060;rport=59910;received=195.62.226.4;x-route-tag="tgrp:Slot6";branch=z9hG4bK101CF0E16CC
From: <sip:[email protected]>;tag=F34CBECC-0
To: <sip:[email protected]>
Call-ID: [email protected]
User-Agent: Cisco-SIPGateway/IOS-12.x
CSeq: 101 INVITE
Max-Forwards: 9
Remote-Party-ID: <sip:[email protected]>;party=calling;screen=yes;privacy=off
Contact: <sip:[email protected]:59910>
Expires: 180
Allow-Events: telephone-event
Content-Type: application/sdp
Content-Length: 419
P-hint: 2 Niente 2

v=0
o=CiscoSystemsSIP-GW-UserAgent 2016 1871 IN IP4 195.62.226.4
s=SIP Call
c=IN IP4 83.211.223.195
t=0 0
m=audio 63062 RTP/AVP 18 8 0 4 3 125 101
c=IN IP4 83.211.223.195
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=yes
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:4 G723/8000
a=fmtp:4 bitrate=5.3;annexa=no
a=rtpmap:3 GSM/8000
a=rtpmap:125 X-CCD/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16

Sep 29 12:39:43.554: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK6cff.bcc656b1.0,SIP/2.0/UDP 195.62.226.4:5060;rport=59910;received=195.62.226.4;x-route-tag="tgrp:Slot6";branch=z9
hG4bK101CF0E16CC
From: <sip:[email protected]>;tag=F34CBECC-0
To: <sip:[email protected]>
Date: Wed, 29 Sep 2010 12:39:43 GMT
Call-ID: [email protected]
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0



Sep 29 12:39:43.558: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 300 Multiple Choices
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK6cff.bcc656b1.0,SIP/2.0/UDP 195.62.226.4:5060;rport=59910;received=195.62.226.4;x-route-tag="tgrp:Slot6";branch=z9
hG4bK101CF0E16CC
From: <sip:[email protected]>;tag=F34CBECC-0
To: <sip:[email protected]>;tag=10BD258-1C9C
Date: Wed, 29 Sep 2010 12:39:43 GMT
Call-ID: [email protected]
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Diversion: <sip:[email protected]>;reason=unconditional
Contact: <sip:[email protected]>,<sip:[email protected]>
Content-Length: 0


Sep 29 12:39:43.618: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:[email protected]:53392 SIP/2.0
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK6cff.bcc656b1.0
From: <sip:[email protected]>;tag=F34CBECC-0
Call-ID: [email protected]
To: <sip:[email protected]>;tag=10BD258-1C9C
CSeq: 101 ACK
Max-Forwards: 70
User-Agent: SPS EUT RM GW 01
Content-Length: 0

A presto :D
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

da un occhiata fugace ho notato che hai usato il dominio pubblico di eutelia (voip.eutelia.it) anche internamente.

Sicenramente non credo che questa cosa vada molto bene. Dai log il 288 viene deviato (Diversion: <sip:[email protected]>;reason=unconditional ) al numeto :

Contact: <sip:[email protected]>,<sip:[email protected]>

Ma il 202 appartiene al dominio voip.eutelia.it che è sia pubblico che privato nel tuo caso, e qui potrebbe esserci un problema ...

Per avere un quadro completo bisognerebbe mettere sotto debig ed analizzare per bene i log.

Ciao Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Buonasera Giulio, quali debug mi consigli di fare?
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

dovresti seguire tutto il flusso della chiamata e vedere dove va a finire una volta attivata la deviazione. Ho la senzazione che la chiamata non vada sul 202 ma se ne torni su eutelia.

Magari inizia a verificare in debug i dial-peer

Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Buongiorno Giulio ecco i dati che mi chiedevi:

Oct 1 07:03:38.852: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 83.211.227.21:5060
Oct 1 07:03:38.852: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
Oct 1 07:03:38.852: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x852AB284
Oct 1 07:03:38.856: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x852AB284, addr=83.211.227.21, port=5060, connid=1, transp
ort=UDP
Oct 1 07:03:38.856: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
INVITE sip:[email protected]:52228 SIP/2.0
Record-Route: <sip:83.211.227.21;lr=on;ftag=DD363FC4-78>
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK5bb4.13811531.0
Via: SIP/2.0/UDP 195.62.226.2:5060;rport=61721;received=195.62.226.2;x-route-tag="tgrp:Slot6";branch=z9hG4bK721C081E9
From: <sip:[email protected]>;tag=DD363FC4-78
To: <sip:[email protected]>
Call-ID: [email protected]
User-Agent: Cisco-SIPGateway/IOS-12.x
CSeq: 101 INVITE
Max-Forwards: 9
Remote-Party-ID: <sip:[email protected]>;party=calling;screen=yes;privacy=off
Contact: <sip:[email protected]:61721>
Expires: 180
Allow-Events: telephone-event
Content-Type: application/sdp
Content-Length: 417
P-hint: 2 Niente 2

v=0
o=CiscoSystemsSIP-GW-UserAgent 2152 4111 IN IP4 195.62.226.2
s=SIP Call
c=IN IP4 83.211.227.11
t=0 0
m=audio 64254 RTP/AVP 18 8 0 4 3 125 101
c=IN IP4 83.211.227.11
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=yes
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:4 G723/8000
a=fmtp:4 bitrate=5.3;annexa=no
a=rtpmap:3 GSM/8000
a=rtpmap:125 X-CCD/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16

Oct 1 07:03:38.860: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
Oct 1 07:03:38.864: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIAddContextToTable: Added context(0x859693FC) with key=[769] to table
Oct 1 07:03:38.864: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060
Oct 1 07:03:38.868: //-1/D9DFB72A8364/SIP/State/sipSPIChangeState: 0x859693FC : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE)
Oct 1 07:03:38.868: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060
Oct 1 07:03:38.868: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone CEST to SIP default timezone = GMT
Oct 1 07:03:38.872: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060
Oct 1 07:03:38.880: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContentGTD: No GTD found in inbound container
Oct 1 07:03:38.880: //-1/D9DFB72A8364/SIP/Info/sipSPIUaddCcbToUASReqTable: ****Adding to UAS Request table.
Oct 1 07:03:38.880: //-1/D9DFB72A8364/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x859693FC [email protected]
0288
Oct 1 07:03:38.884: //-1/D9DFB72A8364/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on carrier id
Oct 1 07:03:38.884: //-1/D9DFB72A8364/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on Incoming called number: XXXXXXX288
Oct 1 07:03:38.884: //-1/D9DFB72A8364/SIP/Info/sipSPIMatchSrcIpGroup: Match not found on destination pattern: 338XXXXXX
Oct 1 07:03:38.884: //-1/D9DFB72A8364/SIP/Info/ccsipUpdateIncomingCallParams: ccCallInfo: Calling name , number 338XXXXXX, Calling oct3 0x00, oct_3a 0x80, Cal
led number XXXXXXXX288
Oct 1 07:03:38.888: //-1/D9DFB72A8364/SIP/Info/sipSPIGetCallConfig: Precondition tag absent in Require/Supported header
Oct 1 07:03:38.888: //-1/D9DFB72A8364/SIP/Info/sipSPIGetCallConfig: Peer tag 3 matched for incoming call
Oct 1 07:03:38.892: //-1/D9DFB72A8364/SIP/Info/sipSPIGetCallConfig: Using Voice Class Codec, tag = 1
Oct 1 07:03:38.892: //-1/D9DFB72A8364/SIP/Info/sipSPIContinueNewMsgInvite: Calling name , number 338XXXXXX, Calling oct3 0x00, oct_3a 0x80, ext_priv 0x00, Cal
led number 05651930288, oct3 0x00
Oct 1 07:03:38.892: //-1/D9DFB72A8364/SIP/Info/sipSPIContinueNewMsgInvite: Carrier id code , prev_cid NONE, next_cid NONE, prev_tgrp Slot6, next_tgrp NONE
Oct 1 07:03:38.892: //-1/D9DFB72A8364/SIP/Info/sipSPIRscmsmAvail: Value returned by check is = 0
Oct 1 07:03:38.900: //252/D9DFB72A8364/SIP/Info/sipSPIDoMediaNegotiation: Number of m-lines = 1
Oct 1 07:03:38.900: //252/D9DFB72A8364/SIP/Media/sipSPISelectCodecVersion: Codec (g729br8) is not in preferred list
Oct 1 07:03:38.900: //252/D9DFB72A8364/SIP/Info/sipSPIDoAudioNegotiation: Codec (g711alaw) Negotiation Successful on Static Payload for m-line 1
Oct 1 07:03:38.904: //252/D9DFB72A8364/SIP/Info/sipSPIDoPtimeNegotiation: No ptime present or multiple ptime attributes that can't be handled
Oct 1 07:03:38.904: //252/D9DFB72A8364/SIP/Info/sipSPIDoDTMFRelayNegotiation: m-line index 1
Oct 1 07:03:38.904: //252/D9DFB72A8364/SIP/Info/sipSPICheckDynPayloadUse: Dynamic payload(101) could not be reserved.
Oct 1 07:03:38.904: //252/D9DFB72A8364/SIP/Info/sipSPIDoDTMFRelayNegotiation: RTP-NTE DTMF relay option
Oct 1 07:03:38.904: //252/D9DFB72A8364/SIP/Info/sipSPIDoDTMFRelayNegotiation: Case of full named event(NE) match in fmtp list of events.
Oct 1 07:03:38.904: //-1/xxxxxxxxxxxx/SIP/Info/sip_sdp_get_modem_relay_cap_params: NSE payload from X-cap = 0
Oct 1 07:03:38.908: //252/D9DFB72A8364/SIP/Info/sip_select_modem_relay_params: X-tmr not present in SDP. Disable modem relay
Oct 1 07:03:38.908: //252/D9DFB72A8364/SIP/Info/sipSPIGetSDPDirectionAttribute: No direction attribute present or multiple direction attributes that can't be h
andled for m-line:1 and num-a-lines:0
Oct 1 07:03:38.908: //252/D9DFB72A8364/SIP/Info/sipSPIDoAudioNegotiation: Codec negotiation successful for media line 1
payload_type=8, codec_bytes=160, codec=g711alaw, dtmf_relay=rtp-nte
stream_type=voice+dtmf (1), dest_ip_address=83.211.227.11, dest_port=64254
Oct 1 07:03:38.908: //252/D9DFB72A8364/SIP/State/sipSPIChangeStreamState: Stream (callid = -1) State changed from (STREAM_DEAD) to (STREAM_ADDING)
Oct 1 07:03:38.908: //252/D9DFB72A8364/SIP/Media/sipSPIUpdCallWithSdpInfo:
Preferred Codec : g711alaw, bytes :160
Preferred DTMF relay : rtp-nte
Preferred NTE payload : 101
Early Media : No
Delayed Media : No
Bridge Done : No
New Media : No
DSP DNLD Reqd : No

Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Media/sipSPISetMediaSrcAddr: Media src addr for stream 1 = XX.XX.XX.139
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_report_media_to_peer:
callId 252 peer 0 flags 0x201
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
CallID 252, sdp 0x8481C7F4 channels 0x8596A4CC
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Info/copy_channels:
callId 252 size 0 ptr 0x85F3B774)
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 18 mline 1
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Media/sipSPISelectCodecVersion: Codec (g729br8) is not in preferred list
Oct 1 07:03:38.912: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: An exact codec match not configured, using interoperable codec g729r8
Oct 1 07:03:38.916: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g729r8
SIP: (252) Attribute ptime, level 1 instance 1 not found.
Oct 1 07:03:38.916: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
Oct 1 07:03:38.916: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g729r8 ptime :0, codecbytes: 0
Oct 1 07:03:38.916: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 20
Oct 1 07:03:38.916: //252/D9DFB72A8364/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:
failed to update call entry
Oct 1 07:03:38.916: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 16 ptype 18 time 0, bytes 20 as channel 0 mline 1 ss 0 83.211.227.11:64254
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 8 mline 1
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711alaw
Oct 1 07:03:38.920: //-1/xxxxxxxxxxxx/SIP/Info/convert_codec_bytes_to_ptime: Values :Codec: g711alaw codecbytes :160, ptime: 20
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation done: stream->negotiated_ptime=0,stream->negotiated_code
c_bytes=160, coverted ptime=20 stream->mline_index=1, media_ndx=1
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:
failed to update call entry
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 6 ptype 8 time 20, bytes 160 as channel 1 mline 1 ss 0 83.211.227.11:64254
Oct 1 07:03:38.920: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 0 mline 1
Oct 1 07:03:38.924: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g711ulaw
SIP: (252) Attribute ptime, level 1 instance 1 not found.
Oct 1 07:03:38.924: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
Oct 1 07:03:38.924: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g711ulaw ptime :0, codecbytes: 0
Oct 1 07:03:38.924: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 160
Oct 1 07:03:38.924: //252/D9DFB72A8364/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:
failed to update call entry
Oct 1 07:03:38.924: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 5 ptype 0 time 0, bytes 160 as channel 2 mline 1 ss 0 83.211.227.11:64254
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 4 mline 1
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Media/sipSPISelectCodecVersion: Codec (g723r53) is not in preferred list
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: An exact codec match not configured, using interoperable codec g729r8 pre-
ietf
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec g729r8 pre-ietf
SIP: (252) Attribute ptime, level 1 instance 1 not found.
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Media negotiation NOT done, get ptime from sdp: ptime=0, media_ndx=1
Oct 1 07:03:38.928: //-1/xxxxxxxxxxxx/SIP/Info/convert_ptime_to_codec_bytes: Values :Codec: g729r8 pre-ietf ptime :0, codecbytes: 0
Oct 1 07:03:38.928: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Codec bytes 0, use default packet rate 20
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Error/sipSPI_ipip_copy_sdp_to_channelInfo:
failed to update call entry
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Adding codec 0 ptype 4 time 0, bytes 20 as channel 3 mline 1 ss 0 83.211.227.11:64254
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 3 mline 1
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: Selecting codec gsmfr
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 125 mline 1
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo:
Hndl ptype 101 mline 1
Oct 1 07:03:38.932: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_copy_sdp_to_channelInfo: setting ipip_caps DTMF to RFC2833: callid = 252, dtmf = 6
Oct 1 07:03:38.936: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_report_media_to_peer:
Report initial call media
Oct 1 07:03:38.936: //252/D9DFB72A8364/SIP/Info/copy_channels:
callId 252 size 408 ptr 0x84DFDB14)
Oct 1 07:03:38.936: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_report_media_to_peer:
CCSIP: Unable to report channel ind
Oct 1 07:03:38.936: //252/D9DFB72A8364/SIP/Media/sipSPIUpdCallWithSdpInfo:
Stream type : voice+dtmf
Media line : 1
State : STREAM_ADDING (2)
Callid : -1
Negotiated Codec : g711alaw, bytes :160
Nego. Codec payload : 8 (tx), 8 (rx)
Negotiated DTMF relay : rtp-nte
Negotiated NTE payload : 101 (tx), 101 (rx)
Negotiated CN payload : 0
Media Srce Addr/Port : xx.xx.xx.139:0
Media Dest Addr/Port : 83.211.227.11:64254

Oct 1 07:03:38.940: //252/D9DFB72A8364/SIP/Info/sipSPIHandleInviteMedia:
Negotiated Codec : g711alaw, bytes :160
Preferred Codec : g711alaw, bytes :160
Preferred DTMF relay 1 : 6
Preferred DTMF relay 2 : 0
Negotiated DTMF relay : 6
Preferred and Negotiated NTE payloads: 101 101
Preferred and Negotiated NSE payloads: 100 0
Preferred and Negotiated Modem Relay: 0 0
Preferred and Negotiated Modem Relay GwXid: 1 0

Oct 1 07:03:38.940: //252/D9DFB72A8364/SIP/Info/sipSPIDoQoSNegotiation: SDP body with media description
Oct 1 07:03:38.940: //252/D9DFB72A8364/SIP/Info/sipSPICanSetFallbackFlag: Local Fallback is not active
Oct 1 07:03:38.940: //-1/xxxxxxxxxxxx/SIP/Media/sipSPIReserveRtpPort: reserved port 16418 for stream 1
Oct 1 07:03:38.944: //252/D9DFB72A8364/SIP/Info/sipSPIUpdateSrcSdpFixedPart: Reserving rtp port for stream 1, src_port=16418
Oct 1 07:03:38.944: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetMediaDirectionForStream: Setting Media direction SENDRECV for stream 1
Oct 1 07:03:38.944: //252/D9DFB72A8364/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Setting stream 1 portnum to 16418
Oct 1 07:03:38.944: //252/D9DFB72A8364/SIP/Info/sipSPIUpdateSrcSdpVariablePart: Negotiated method of dtmf relayand pyld: 6 101

Oct 1 07:03:38.948: //252/D9DFB72A8364/SIP/Info/sipSPIAddBillingInfoToCcb: sipCallId for billing records = [email protected]
Oct 1 07:03:38.948: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_store_channel_info: Store channelInfo in CallInfo
Oct 1 07:03:38.948: //252/D9DFB72A8364/SIP/Info/sipSPI_ipip_store_channel_info: dtmf negotiation done, storing negotiated dtmf = 6,
Oct 1 07:03:38.948: //-1/xxxxxxxxxxxx/SIP/Info/sipSPICreateRawMsg: No GTD passed.
Oct 1 07:03:38.948: //252/D9DFB72A8364/SIP/Info/ccsip_set_bearer_capability:
Bearer Capability: Speech (0x00)
Oct 1 07:03:38.952: //252/D9DFB72A8364/SIP/Info/sipSPIContinueNewMsgInvite: ccsip_api_call_setup_ind returned: SIP_SUCCESS
Oct 1 07:03:38.952: //252/D9DFB72A8364/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id FC to table
Oct 1 07:03:38.960: //252/D9DFB72A8364/SIP/Transport/sipSPITransportSendMessage: msg=0x8592CBB0, addr=83.211.227.21, port=5060, sentBy_port=5060, is_req=0, tra
nsport=1, switch=0, callBack=0x00000000
Oct 1 07:03:38.960: //252/D9DFB72A8364/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
Oct 1 07:03:38.960: //252/D9DFB72A8364/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
Oct 1 07:03:38.960: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x8592CBB0, addr=83.211.227.21, port=5060, connId=0 for U
DP
Oct 1 07:03:38.960: //252/D9DFB72A8364/SIP/State/sipSPIChangeState: 0x859693FC : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_RECD_INVITE, SUBSTATE
_NONE)
Oct 1 07:03:38.960: //252/D9DFB72A8364/SIP/Info/sipSPIProcessContactInfo: Previous Hop 83.211.227.21:5060
Oct 1 07:03:38.968: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_PROCEEDING
Oct 1 07:03:38.984: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 3
Oct 1 07:03:38.992: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK5bb4.13811531.0,SIP/2.0/UDP 195.62.226.2:5060;rport=61721;received=195.62.226.2;x-route-tag="tgrp:Slot6";branch=z9
hG4bK721C081E9
From: <sip:[email protected]>;tag=DD363FC4-78
To: <sip:[email protected]>
Date: Fri, 01 Oct 2010 07:03:38 GMT
Call-ID: [email protected]
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Content-Length: 0


Oct 1 07:03:39.000: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_call_forward:

ccsip_call_forward

Oct 1 07:03:39.000: //252/D9DFB72A8364/SIP/Info/ccsip_call_forward: Call forward target num 202
Oct 1 07:03:39.000: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_FORWARD
Oct 1 07:03:39.004: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 28
Oct 1 07:03:39.004: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIgetRegistrarHost: registrar host retrieved
Oct 1 07:03:39.008: //252/D9DFB72A8364/SIP/Info/ccsip_spi_create_call_forward_contact_list: Call forward dpeer tag: 20008
Oct 1 07:03:39.008: //252/D9DFB72A8364/SIP/Info/ccsip_spi_create_call_forward_contact_list: Call forward dpeer tag: 3
Oct 1 07:03:39.008: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIgetRegistrarHost: registrar host retrieved
Oct 1 07:03:39.012: //252/D9DFB72A8364/SIP/Info/ccsip_spi_add_redirect_contact: found voip peer, using session target as contact
Oct 1 07:03:39.012: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIgetRegistrarHost: registrar host retrieved
Oct 1 07:03:39.012: //252/D9DFB72A8364/SIP/Info/ccsip_spi_create_call_forward_contact_list: Number of redirect contacts added: 2
Oct 1 07:03:39.012: //252/D9DFB72A8364/SIP/Info/act_spi_call_forward:
Performing call forward

Oct 1 07:03:39.016: //252/D9DFB72A8364/SIP/Info/act_spi_call_forward:
Sending 3xx response
Oct 1 07:03:39.020: //252/D9DFB72A8364/SIP/Info/sipSPISendInviteResponse: Associated container=0x8618ACA4 to Invite Response 300
Oct 1 07:03:39.020: //252/D9DFB72A8364/SIP/Transport/sipSPITransportSendMessage: msg=0x84AE7A18, addr=83.211.227.21, port=5060, sentBy_port=5060, is_req=0, tra
nsport=1, switch=0, callBack=0x80D551C0
Oct 1 07:03:39.020: //252/D9DFB72A8364/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately
Oct 1 07:03:39.020: //252/D9DFB72A8364/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0
Oct 1 07:03:39.020: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x84AE7A18, addr=83.211.227.21, port=5060, connId=0 for U
DP
Oct 1 07:03:39.024: //252/D9DFB72A8364/SIP/Info/sentInviteResponseRedMovedTemp: Sent an 3456XX Error Response
Oct 1 07:03:39.024: //252/D9DFB72A8364/SIP/Info/sipSPIInitiateDisconnect: Initiate call disconnect(16) for incoming call
Oct 1 07:03:39.024: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_set_release_source_for_peer: ownCallId[252], src[6]
Oct 1 07:03:39.024: //252/D9DFB72A8364/SIP/State/sipSPIChangeState: 0x859693FC : State change from (STATE_RECD_INVITE, SUBSTATE_NONE) to (STATE_DISCONNECTING,
SUBSTATE_NONE)
Oct 1 07:03:39.028: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Sent:
SIP/2.0 300 Multiple Choices
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK5bb4.13811531.0,SIP/2.0/UDP 195.62.226.2:5060;rport=61721;received=195.62.226.2;x-route-tag="tgrp:Slot6";branch=z9
hG4bK721C081E9
From: <sip:[email protected]>;tag=DD363FC4-78
To: <sip:[email protected]>;tag=3D2A618-1D54
Date: Fri, 01 Oct 2010 07:03:38 GMT
Call-ID: [email protected]
CSeq: 101 INVITE
Allow-Events: telephone-event
Server: Cisco-SIPGateway/IOS-12.x
Diversion: <sip:[email protected]>;reason=unconditional
Contact: <sip:[email protected]>,<sip:[email protected]>
Content-Length: 0


Oct 1 07:03:39.036: //-1/xxxxxxxxxxxx/SIP/Event/sipSPIEventInfo: Queued event from SIP SPI : SIPSPI_EV_CC_CALL_DISCONNECT
Oct 1 07:03:39.040: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 3 for event 7
Oct 1 07:03:39.076: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 83.211.227.21:5060
Oct 1 07:03:39.076: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_process_sipspi_queue_event: ccsip_spi_get_msg_type returned: 2 for event 1
Oct 1 07:03:39.080: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x852AB284
Oct 1 07:03:39.080: //-1/xxxxxxxxxxxx/SIP/Transport/sipConnectionManagerProcessNewConnMsg: gConnTab=0x852AB284, addr=83.211.227.21, port=5060, connid=1, transp
ort=UDP
Oct 1 07:03:39.080: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg:
Received:
ACK sip:[email protected]:52228 SIP/2.0
Via: SIP/2.0/UDP 83.211.227.21;branch=z9hG4bK5bb4.13811531.0
From: <sip:[email protected]>;tag=DD363FC4-78
Call-ID: [email protected]
To: <sip:[email protected]>;tag=3D2A618-1D54
CSeq: 101 ACK
Max-Forwards: 70
User-Agent: SPS EUT RM GW 01
Content-Length: 0



Oct 1 07:03:39.080: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_new_msg_preprocessor: Checking Invite Dialog
Oct 1 07:03:39.084: //252/D9DFB72A8364/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x859693FC
Oct 1 07:03:39.088: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060
Oct 1 07:03:39.088: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone CEST to SIP default timezone = GMT
Oct 1 07:03:39.092: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060
Oct 1 07:03:39.092: //252/D9DFB72A8364/SIP/Info/sipSPIIcpifUpdate: CallState: 2 Playout: 0 DiscTime:6413680 ConnTime 0
Oct 1 07:03:39.096: //252/D9DFB72A8364/SIP/State/sipSPIChangeState: 0x859693FC : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTA
TE_NONE)
Oct 1 07:03:39.096: //252/D9DFB72A8364/SIP/Call/sipSPICallInfo:
The Call Setup Information is:
Call Control Block (CCB) : 0x859693FC
State of The Call : STATE_DEAD
TCP Sockets Used : NO
Calling Number : 338xxxxxxxx
Called Number : xxxxxxxx288
Source IP Address (Sig ): xx.xx.xx.139
Destn SIP Req Addr:Port : 83.211.227.21:5060
Destn SIP Resp Addr:Port : 83.211.227.21:5060
Destination Name : 83.211.227.21

Oct 1 07:03:39.100: //252/D9DFB72A8364/SIP/Call/sipSPIMediaCallInfo:
Number of Media Streams: 1
Media Stream : 1
Negotiated Codec : g711alaw
Negotiated Codec Bytes : 160
Nego. Codec payload : 8 (tx), 8 (rx)
Negotiated Dtmf-relay : 6
Dtmf-relay Payload : 101 (tx), 101 (rx)
Source IP Address (Media): xx.xx.xx.139
Source IP Port (Media): 16418
Destn IP Address (Media): 83.211.227.11
Destn IP Port (Media): 64254
Orig Destn IP Address:Port (Media): 0.0.0.0:0

Oct 1 07:03:39.100: //252/D9DFB72A8364/SIP/Call/sipSPICallInfo:
Disconnect Cause (CC) : 16
Disconnect Cause (SIP) : 302

Oct 1 07:03:39.100: //252/D9DFB72A8364/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id FC
Oct 1 07:03:39.100: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIDeleteContextFromTable: Context for key=[769] removed.
Oct 1 07:03:39.100: //252/D9DFB72A8364/SIP/Info/sipSPIUdeleteCcbFromUASReqTable: ****Deleting from UAS Request table.
Oct 1 07:03:39.104: //252/D9DFB72A8364/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x859693FC [email protected]
26.205651930288
Oct 1 07:03:39.104: //252/D9DFB72A8364/SIP/Info/sipSPIUdeleteCcbFromUASRespTable: ****Deleting from UAS Response table.
Oct 1 07:03:39.104: //252/D9DFB72A8364/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd
Oct 1 07:03:39.108: //252/D9DFB72A8364/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 859693FC
Oct 1 07:03:39.108: //-1/xxxxxxxxxxxx/SIP/Info/sipSPIGetContextFromTable: NO context for key[769]

Ti ringrazio in anticipo per il tuo prezioso aiuto. :D
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

che versione di call manager e di IOS hai ?

Ciao Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

Lo ios è c1700-advipservicesk9-mz.124-15.T11.bin mentre il cme è la versione 4.1
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

ok. Inserisci questi due comandi e prova :


no supplementary-service sip moved-temporarily
no supplementary-service sip refer


E prova .... se ancora non va allora fai :

debug voip ccapi inout

e posta i log.

Ciao Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
lucaspag
Cisco fan
Messaggi: 47
Iscritto il: sab 28 mar , 2009 11:14 am

:D :D :D Grazie mille Giulio adesso funziona!!!
Avatar utente
IsaCab
Network Emperor
Messaggi: 349
Iscritto il: ven 18 gen , 2008 3:45 pm
Contatta:

Ciao,

ottimo, grazie a te per il feedback.

Giulio
-------
Giulio Martino [ http://www.voipexperts.it ]
Avaya IP Office PA
Microsoft MCP [IsaServer]
Cisco SMB[AM,EN] - SBCS [AM,EN]
Technical Writer e Supporter di ISAServer.it
Articoli - <http://www.isaserver.it/articoli/>
Forum - <http://www.isaserver.it/forum/>
Blog - <http://blogs.dotnethell.it/isacab/>
Rispondi