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.
