savinge# 000026: Dec 30 09:51:38.473 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 83.211.227.21:5060 000027: Dec 30 09:51:38.473 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x8400F74C 000028: Dec 30 09:51:38.477 ITALY: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg: Received: INVITE sip:041XXXXXX@87.28.118.111:49831 SIP/2.0 Record-Route: Record-Route: Via: SIP/2.0/UDP 83.211.227.21;branch=0 Via: SIP/2.0/UDP 83.211.227.13;branch=z9hG4bK2d91.1b8d8792.1 Via: SIP/2.0/UDP 62.94.71.96:5060;rport=51365;branch=z9hG4bKF60691A21 From: ;tag=C0CDB408-1399 To: Call-ID: E799062A-D58511DD-9AF6A3C4-7F1F8111@62.94.71.96 Supported: rel1xx,timer,replaces CSeq: 102 INVITE Max-Forwards: 15 Remote-Party-ID: ;party=calling;screen=yes;privacy=off Contact: Expires: 180 Content-Type: application/sdp Content-Length: 438 v=0 o=CiscoSystemsSIP-GW-UserAgent 4445 2713 IN IP4 62.94.71.96 s=SIP Call c=IN IP4 62.94.199.37 t=0 0 m=audio 64396 RTP/AVP 18 8 0 4 3 125 101 19 c=IN IP4 62.94.199.37 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 a=rtpmap:19 CN/8000 000029: Dec 30 09:51:38.481 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060 000030: Dec 30 09:51:38.481 ITALY: //-1/E7A6CCCA8005/SIP/State/sipSPIChangeState: 0x8465FF74 : State change from (STATE_NONE, SUBSTATE_NONE) to (STATE_IDLE, SUBSTATE_NONE) 000031: Dec 30 09:51:38.485 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060 000032: Dec 30 09:51:38.485 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone ITALY to SIP default timezone = GMT 000033: Dec 30 09:51:38.485 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Dialog Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060 000034: Dec 30 09:51:38.489 ITALY: //-1/xxxxxxxxxxxx/SIP/Error/sipSPI_validate_own_ip_addr: ReqLine IP addr does not match with host IP addr 000035: Dec 30 09:51:38.489 ITALY: //-1/E7A6CCCA8005/SIP/Error/sact_idle_new_message_invite: Invalid URL in incoming INVITE 000036: Dec 30 09:51:38.489 ITALY: //-1/E7A6CCCA8005/SIP/Info/ccsip_set_cc_cause_for_spi_err: Categorized cause:100, category:100 000037: Dec 30 09:51:38.489 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_set_release_source_for_peer: ownCallId[-1], src[6] 000038: Dec 30 09:51:38.493 ITALY: //-1/E7A6CCCA8005/SIP/Info/sipSPIUaddCcbToUASReqTable: ****Adding to UAS Request table. 000039: Dec 30 09:51:38.493 ITALY: //-1/E7A6CCCA8005/SIP/Info/sipSPIUaddCcbToTable: Added to table. ccb=0x8465FF74 key=E799062A-D58511DD-9AF6A3C4-7F1F8111@62.94.71.96041XXXXXX 000040: Dec 30 09:51:38.493 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUaddccCallIdToTable: Adding call id 3 to table 000041: Dec 30 09:51:38.497 ITALY: //3/E7A6CCCA8005/SIP/Transport/sipSPITransportSendMessage: msg=0x848876F0, addr=83.211.227.21, port=5060, sentBy_port=5060, is_req=0, transport=1, switch=0, callBack=0x80BD9C74 000042: Dec 30 09:51:38.497 ITALY: //3/E7A6CCCA8005/SIP/Transport/sipSPITransportSendMessage: Proceedable for sending msg immediately 000043: Dec 30 09:51:38.497 ITALY: //3/E7A6CCCA8005/SIP/Transport/sipTransportLogicSendMsg: switch transport is 0 000044: Dec 30 09:51:38.497 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostSendMessage: Posting send for msg=0x848876F0, addr=83.211.227.21, port=5060, connId=0 for UDP 000045: Dec 30 09:51:38.501 ITALY: //3/E7A6CCCA8005/SIP/Info/sentErrResDisconnecting: Sent an 3456XX Error Response 000046: Dec 30 09:51:38.501 ITALY: //3/E7A6CCCA8005/SIP/State/sipSPIChangeState: 0x8465FF74 : State change from (STATE_IDLE, SUBSTATE_NONE) to (STATE_DISCONNECTING, SUBSTATE_NONE) 000047: Dec 30 09:51:38.505 ITALY: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg: Sent: SIP/2.0 400 Bad Request - 'Invalid IP Address' Via: SIP/2.0/UDP 83.211.227.21;branch=0,SIP/2.0/UDP 83.211.227.13;branch=z9hG4bK2d91.1b8d8792.1,SIP/2.0/UDP 62.94.71.96:5060;rport=51365;branch=z9hG4bKF60691A21 From: ;tag=C0CDB408-1399 To: ;tag=244C040-2056 Date: Tue, 30 Dec 2008 08:51:38 GMT Call-ID: E799062A-D58511DD-9AF6A3C4-7F1F8111@62.94.71.96 Server: Cisco-SIPGateway/IOS-12.x CSeq: 102 INVITE Allow-Events: telephone-event Content-Length: 0 000048: Dec 30 09:51:38.553 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/HandleUdpSocketReads: Msg enqueued for SPI with IP addr: 83.211.227.21:5060 000049: Dec 30 09:51:38.557 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportProcessNWNewConnMsg: context=0x8400F74C 000050: Dec 30 09:51:38.557 ITALY: //-1/xxxxxxxxxxxx/SIP/Msg/ccsipDisplayMsg: Received: ACK sip:041XXXXXX@87.28.118.111:49831 SIP/2.0 Max-Forwards: 15 Record-Route: Via: SIP/2.0/UDP 83.211.227.21;branch=0 Via: SIP/2.0/UDP 83.211.227.13;branch=z9hG4bK2d91.1b8d8792.1 From: ;tag=C0CDB408-1399 Call-ID: E799062A-D58511DD-9AF6A3C4-7F1F8111@62.94.71.96 To: ;tag=244C040-2056 CSeq: 102 ACK Content-Length: 0 000051: Dec 30 09:51:38.557 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIFindCcbUASReqTable: *****CCB found in UAS Request table. ccb=0x8465FF74 000052: Dec 30 09:51:38.561 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060 000053: Dec 30 09:51:38.561 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/sipSPISetDateHeader: Converting TimeZone ITALY to SIP default timezone = GMT 000054: Dec 30 09:51:38.565 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipSPIUpdateResponseInfo: Subsq Transaction Address 83.211.227.21,Port 5060, Transport 1, SentBy Port 5060 000055: Dec 30 09:51:38.565 ITALY: //3/E7A6CCCA8005/SIP/State/sipSPIChangeState: 0x8465FF74 : State change from (STATE_DISCONNECTING, SUBSTATE_NONE) to (STATE_DEAD, SUBSTATE_NONE) 000056: Dec 30 09:51:38.565 ITALY: //3/E7A6CCCA8005/SIP/Call/sipSPICallInfo: The Call Setup Information is: Call Control Block (CCB) : 0x8465FF74 State of The Call : STATE_DEAD TCP Sockets Used : NO Calling Number : Called Number : 041XXXXXX Source IP Address (Sig ): 192.168.1.2 Destn SIP Req Addr:Port : 83.211.227.21:0 Destn SIP Resp Addr:Port : 83.211.227.21:5060 Destination Name : 83.211.227.21 000057: Dec 30 09:51:38.569 ITALY: //3/E7A6CCCA8005/SIP/Call/sipSPICallInfo: Disconnect Cause (CC) : 100 Disconnect Cause (SIP) : 200 000058: Dec 30 09:51:38.569 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUdeleteccCallIdFromTable: Removing call id 3 000059: Dec 30 09:51:38.569 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUdeleteCcbFromUASReqTable: ****Deleting from UAS Request table. 000060: Dec 30 09:51:38.569 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUdeleteCcbFromTable: Deleting from table. ccb=0x8465FF74 key=E799062A-D58511DD-9AF6A3C4-7F1F8111@62.94.71.96041XXXXXX 000061: Dec 30 09:51:38.569 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUdeleteCcbFromUASRespTable: ****Deleting from UAS Response table. savinge# 000062: Dec 30 09:51:38.573 ITALY: //3/E7A6CCCA8005/SIP/Error/sipSPIUdeleteCcbFromTable: Cannot delete from table. Search key is NULL 000063: Dec 30 09:51:38.573 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIFlushEventBufferQueue: There are 0 events on the internal queue that are going to be free'd 000064: Dec 30 09:51:38.573 ITALY: //3/E7A6CCCA8005/SIP/Info/sipSPIUfreeOneCCB: Freeing ccb 8465FF74 savinge# 000065: Dec 30 09:51:59.418 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipInstanceHandleConnAgeing: Connection=0x8401010C, addr=83.211.227.21, port=5060, connid=1 has been aged out 000066: Dec 30 09:51:59.418 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportPostCloseConnection: Posting UDP conn close for addr=83.211.227.21, port=5060, connid=1 000067: Dec 30 09:51:59.418 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipDeleteConnInstance: Deleted conn=0x8401010C, connid=1, addr=83.211.227.21, port=5060, transport=udp 000068: Dec 30 09:51:59.418 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportSetAgeingTimer: Aging timer initiated for holder=0x84887780,addr=83.211.227.21 savinge# 000069: Dec 30 09:51:59.418 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipTransportStopAgeingTimer: Aging timer stopped for holder=0x84887780,addr=83.211.227.21 000070: Dec 30 09:51:59.422 ITALY: //-1/xxxxxxxxxxxx/SIP/Transport/sipDeleteConnHolder: Deleted holder=0x84887780, addr=83.211.227.21, count=0 000071: Dec 30 09:51:59.422 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/udpsock_close_connect: Socket fd: 1 closed for connid 1 with remote port: 5060 savinge# 000072: Dec 30 09:53:59.284 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_spi_register_free_rcb: Freeing rcb 000073: Dec 30 09:53:59.284 ITALY: //-1/xxxxxxxxxxxx/SIP/Info/ccsip_register_reset_dns_cache: CCSIP_REGISTER:: Primary registrar DNS resolved addr reset savinge#