- Cisco Community
- Technology and Support
- Collaboration
- IP Telephony and Phones
- Problem With Jabber for Android.
- Subscribe to RSS Feed
- Mark Topic as New
- Mark Topic as Read
- Float this Topic for Current User
- Bookmark
- Subscribe
- Mute
- Printer Friendly Page
Problem With Jabber for Android.
- Mark as New
- Bookmark
- Subscribe
- Mute
- Subscribe to RSS Feed
- Permalink
- Report Inappropriate Content
05-24-2013 09:18 AM - edited 03-16-2019 05:29 PM
Hi All,
Good Morning.
I recently want to install jabber for android and I've expericend a lor fo problems with so many model of android Phones.
At the first, android was working well but after one day, I does not working anymore.I've trying to deleting the device and enable it again on CUCM and Also tryed to reinstalling in the Phone.
When I debug the Android in Call Manager, I always get this error.
10:53:57.070 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157208^10.32.100.111^BOTL01460667
Here are the debug.
10:59:48.034 |SIPStationInit: connID=38816, BOTL01460667, 10.32.100.111:60372, Routing to D (5,100,199,832), regCount=1|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) - isMobileClientDMIConfigured, no MI configured|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) checkSingleRegRequest -- dual registration case|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) SIPRegisterInd, dual registration case. MtPreferredMode = 0, oldMtPreferredMode = 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) checkNoMIDeviceRegRequest -- no MI case: good dual registration message|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) SIPRegisterInd, device name = BOTL01460667, sipstationd connection index=38816|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.036 |<MN::Directory Number><MV::805243375>|0,0,0,0.0^*^*
10:59:48.038 |SIPEventPkg::subscribeReq address list is NOT empty|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |getCcdSafRouteFromAddrList SafTransAddrList is empty|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |SIPEventPkg::subscribeReq exp = 33776 t = 31976 caller = 805243375, callee = ac821ca7-6099-1e40-eb68-daf6308972c9|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |LineControl(123817) - BOTL01460667 registered, CEPN=263d118e-aa8c-e49f-7f0f-856023fcf7b1, deviceType=8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |No associated device or user.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |LineControl(123817) - 0 calls, 0 CiReq, busyTrigger=2, maxCall=3|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 3 for event 42|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Associated container=0x87787448 to REGISTER Response 200|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Sending INFO Response to the transport layer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/msg=0x18d9c4d0, addr=10.32.100.111, port=60372, sentBy_port=60372, is_req=0, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Trying to send resp=0x18d9c4d0 to default port=60372|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gcb=0xfc2e818 is already on connection=0x13621d40 context_list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Connection obtained...sending msg=0x18d9c4d0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Posting send for msg=0x18d9c4d0, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/****Deleting from UAS Request table.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Deleting from table. ccb=0xfc2e818 key=00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111805243375000000000000000235e26b14-1d7941af|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Removing call id 3f79d3|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Context for key=[4157366] removed.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/There are 0 events on the internal queue that are going to be free'd|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gConnTab=0xf13f240, addr=10.32.100.111, port=60372, unregistering context=0xfc2e818|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Purging context gcb=0xfc2e818 from the connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Freeing ccb fc2e818|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/NO context for key[4157366]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gcb has cleanedup, Done with send operations for this context|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/NO context for key[4157366]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |DeviceManager::star_DmUpdateRoamingInfo - DeviceMobility is disabled for the device = [BOTL01460667], Checking if we need to de-associate Roaming Device Pool.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |DeviceManager::star_DmUpdateRoamingInfo - Roaming Device pool is empty or null|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522367,NET]
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.32.100.111:60372;branch=z9hG4bK0a646f97
From: <sip:805243375@10.2.50.8>;tag=000000000000000235e26b14-1d7941af
To: <sip:805243375@10.2.50.8>;tag=1438577607
Date: Fri, 24 May 2013 15:59:48 GMT
Call-ID: 00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111
CSeq: 101 REGISTER
Expires: 660
Contact: <sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=tcp>;+sip.instance="<urn:uuid:00000000-0000-0000-0000-000000000000>";+sip.instance="<urn:uuid:00000000-0000-0000-0000-000000000000>";+u.sip!devicename.ccm.cisco.com="BOTL01460667";+u.sip!model.ccm.cisco.com="575";x-cisco-newreg
Supported: X-cisco-srtp-fallback,X-cisco-sis-5.2.0
Content-Length: 0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159957|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Added context(0xfc42a80) with key=[4157367] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=4159957/ccsip_platform_init_scb: scb mgmt added 0xfc42a80 (context_id=4157367)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Created new scb: 0xfc42a80 with id: 4159957|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 209|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_REFER] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Inserting SCB with key 4159957 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41b10|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/TCB 0xfc41b10's parent is 0xfc42a80|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Initiating Out-Of-Call-Context Refer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba6-832020a@10.2.50.8542272426|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/Inserting SCB with key f4687780-19f18e74-1ba6-832020a@10.2.50.8542272426 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/No registrar cfg. Using default value for refby host : 10.2.50.8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc41b10's method is 110|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB(0xfc41b10) has claimed possesion of package (0x880f99c0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d0f36113e06|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created new edb(0xfc49a90)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/EDB updated with Event Name: refer Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/Q'd EDB(0xfc49a90) on SCB(0xfc42a80)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41b10) on EDB(0xfc49a90)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41b10 and parent: 0xfc42a80
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/msg=0x880f99c0, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc42a80 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/Set to send the msg=0x880f99c0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Posting send for msg=0x880f99c0, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41b10) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created timer context(0x856f2228)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522368,NET]
REFER sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d0f36113e06
From: <sip:805243375@10.2.50.8>;tag=542272426
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba6-832020a@10.2.50.8
CSeq: 101 REFER
Max-Forwards: 70
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
User-Agent: Cisco-CUCM8.6
Require: norefersub
Expires: 0
Refer-To: cid:1234567890@10.2.50.8
Content-Id: <1234567890@10.2.50.8>
Content-Type: application/x-cisco-remotecc-request+xml
Referred-By: <sip:805243375@10.2.50.8>
Content-Length: 193
<x-cisco-remotecc-request>
<cfwdallupdate>
<linenumber>1</linenumber>
<fwdaddress></fwdaddress>
<tovoicemail>off</tovoicemail>
</cfwdallupdate>
</x-cisco-remotecc-request>
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159958|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Added context(0x87f6a360) with key=[4157368] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=4159958/ccsip_platform_init_scb: scb mgmt added 0x87f6a360 (context_id=4157368)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Created new scb: 0x87f6a360 with id: 4159958|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Inserting SCB with key 4159958 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created TCB: 0xfc419a0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc419a0's parent is 0x87f6a360|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba7-832020a@10.2.50.81779673145|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Inserting SCB with key f4687780-19f18e74-1ba7-832020a@10.2.50.81779673145 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc419a0's method is 111|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB(0xfc419a0) has claimed possesion of package (0x888842e8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d102c019479|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created new edb(0xfc49bf0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/EDB updated with Event Name: service-control Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Q'd EDB(0xfc49bf0) on SCB(0x87f6a360)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc419a0) on EDB(0xfc49bf0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc419a0 and parent: 0x87f6a360
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/msg=0x888842e8, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Registering gcb=0x87f6a360 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/Set to send the msg=0x888842e8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Posting send for msg=0x888842e8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc419a0) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created timer context(0x85d29cc0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522369,NET]
NOTIFY sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d102c019479
From: <sip:10.2.50.8>;tag=1779673145
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba7-832020a@10.2.50.8
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: service-control
Subscription-State: active
Contact: <sip:10.2.50.8:5060;transport=tcp>
Content-Type: text/plain
Content-Length: 283
action=check-version
RegisterCallId={00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111}
ConfigVersionStamp={1369411077-ca34b1ee-c054-4947-ae19-3398608276d1}
DialplanVersionStamp={}
SoftkeyVersionStamp={}
FeatureControlVersionStamp={0000000000-c7a6c673-7479-46b0-839e-014d3d093963}
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159959|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Added context(0x8a96ba38) with key=[4157369] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=4159959/ccsip_platform_init_scb: scb mgmt added 0x8a96ba38 (context_id=4157369)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Created new scb: 0x8a96ba38 with id: 4159959|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 209|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_REFER] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Inserting SCB with key 4159959 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41830|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB 0xfc41830's parent is 0x8a96ba38|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Initiating Out-Of-Call-Context Refer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba8-832020a@10.2.50.8907362330|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Inserting SCB with key f4687780-19f18e74-1ba8-832020a@10.2.50.8907362330 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/No registrar cfg. Using default value for refby host : 10.2.50.8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB 0xfc41830's method is 110|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB(0xfc41830) has claimed possesion of package (0x87c47e70)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d11da64ca9|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created new edb(0xb0974110)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/EDB updated with Event Name: refer Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Q'd EDB(0xb0974110) on SCB(0x8a96ba38)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41830) on EDB(0xb0974110)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41830 and parent: 0x8a96ba38
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/msg=0x87c47e70, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Registering gcb=0x8a96ba38 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/Set to send the msg=0x87c47e70|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Posting send for msg=0x87c47e70, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41830) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created timer context(0x877019d8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522370,NET]
REFER sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d11da64ca9
From: <sip:805243375@10.2.50.8>;tag=907362330
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba8-832020a@10.2.50.8
CSeq: 101 REFER
Max-Forwards: 70
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
User-Agent: Cisco-CUCM8.6
Require: norefersub
Expires: 0
Refer-To: cid:1234567890@10.2.50.8
Content-Id: <1234567890@10.2.50.8>
Content-Type: application/x-cisco-remotecc-request+xml
Referred-By: <sip:805243375@10.2.50.8>
Content-Length: 133
<x-cisco-remotecc-request>
<dndupdate>
<state>disable</state>
<option>callreject</option>
</dndupdate>
</x-cisco-remotecc-request>
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159960|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Added context(0xfc436f0) with key=[4157370] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=4159960/ccsip_platform_init_scb: scb mgmt added 0xfc436f0 (context_id=4157370)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Created new scb: 0xfc436f0 with id: 4159960|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Inserting SCB with key 4159960 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41c80|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41c80's parent is 0xfc436f0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba9-832020a@10.2.50.81491309815|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Inserting SCB with key f4687780-19f18e74-1ba9-832020a@10.2.50.81491309815 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41c80's method is 111|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB(0xfc41c80) has claimed possesion of package (0x85ff1f00)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d122e1d329c|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created new edb(0xfc49eb0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/EDB updated with Event Name: message-summary Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Q'd EDB(0xfc49eb0) on SCB(0xfc436f0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41c80) on EDB(0xfc49eb0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41c80 and parent: 0xfc436f0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/msg=0x85ff1f00, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc436f0 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/Set to send the msg=0x85ff1f00|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85ff1f00, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41c80) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created timer context(0x888c3be8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522371,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d122e1d329c
From: <sip:805243375@10.2.50.8>;tag=1491309815
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba9-832020a@10.2.50.8
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: message-summary
Subscription-State: active
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Type: application/simple-message-summary
Content-Length: 22
Messages-Waiting: no
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159956|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Added context(0xfc468b0) with key=[4157371] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=4159956/ccsip_platform_init_scb: scb mgmt added 0xfc468b0 (context_id=4157371)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Created new scb: 0xfc468b0 with id: 4159956|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 205|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_SUBSCRIBE] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Inserting SCB with key 4159956 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41270|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41270's parent is 0xfc468b0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Initiating Out-Of-Call-Context Subscription|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1baa-832020a@10.2.50.8263107937|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Inserting SCB with key f4687780-19f18e74-1baa-832020a@10.2.50.8263107937 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/TCB 0xfc41270's method is 112|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/TCB(0xfc41270) has claimed possesion of package (0x85a73af8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d136ff69e|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Created new edb(0xfc4a2d0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/EDB updated with Event Name: dialog Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/Q'd EDB(0xfc4a2d0) on SCB(0xfc468b0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41270) on EDB(0xfc4a2d0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41270 and parent: 0xfc468b0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/msg=0x85a73af8, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc468b0 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/Set to send the msg=0x85a73af8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85a73af8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41270) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Created timer context(0x8506de20)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522372,NET]
SUBSCRIBE sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d136ff69e
From: <sip:805243375@10.2.50.8>;tag=263107937
To: <sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111>
Call-ID: f4687780-19f18e74-1baa-832020a@10.2.50.8
CSeq: 101 SUBSCRIBE
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Expires: 33776
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Accept: application/dialog-info+xml
Max-Forwards: 69
Content-Length: 0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.080 |SIPStationInit: connID=38816, BOTL01460667, 10.32.100.111:60372, Routed signal by connection index to (5,100,199,832)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::subscribeInd exp = 42128, t = 43928|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::notifierRouteAndAuthorize|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::sendSIPSubResponse 200|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::notifierNotifyReq|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 203|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_SUBSCRIBE_RESP] received in State [SUBSCRIBE_STATE_DIALOG_PENDING]|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/TCB(0xfc413e0) has claimed possesion of package (0x85af6cb8)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc413e0 and parent: 0xfc47520
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/msg=0x85af6cb8, addr=10.32.100.111, port=60372, sentBy_port=60372, is_req=0, transport=2, switch=0, callBack=|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Trying to send resp=0x85af6cb8 to default port=60372|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc47520 with connection=0x13621d40 context list|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Connection obtained...sending msg=0x85af6cb8|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85af6cb8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBServer...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Sizeof tcbQ: 1|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/DeQ'd TCB(0xfc413e0) from EDB(0x8a708608)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/EnQing TCB(0xfc413e0) for reuse|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_DIALOG_PENDING to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522374,NET]
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.32.100.111:60372;branch=z9hG4bK14f07032
From: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
To: <sip:805243375@10.2.50.8>;tag=1321680832
Date: Fri, 24 May 2013 15:59:48 GMT
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 1000 SUBSCRIBE
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Expires: 42128
Content-Length: 0
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_ACTIVE]|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41100|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB 0xfc41100's parent is 0xfc47520|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present: TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB 0xfc41100's method is 111|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB(0xfc41100) has claimed possesion of package (0x85a27518)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d1451d19f9c|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0xfc47520/Entering ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41100) on EDB(0x8a708608)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0xfc47520/There are 1 TCB's on tcbQ|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41100 and parent: 0xfc47520
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/msg=0x85a27518, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/gcb=0xfc47520 is already on connection=0x13621d40 context_list|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/Set to send the msg=0x85a27518|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85a27518, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41100) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Created timer context(0x856375c8)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522375,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d1451d19f9c
From: <sip:805243375@10.2.50.8>;tag=1321680832
To: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Subscription-State: active;expires=42128
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Type: application/dialog-info+xml
Content-Length: 266
<dialog-info xmlns="urn:ietf:parmams:xml:ns:dialog-info"
xmlns:call="urn:x-cisco:parmams:xml:ns:dialog-info:dialog:callinfo-dialog"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
version="1" state="full" entity="sip:805243375@10.2.50.8">
</dialog-info>
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.504 |SIPStationInit: connID=38816, BOTL01460667, 10.32.100.111:60372, Routed signal by connection index to (5,100,199,832)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::notifierNotifyResult result = 400 termNot not sent continuing|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::notifierNotifyResult result = 400|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::stop mStopped=false|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg:sendExternalFinalNotify state = 3 reason = 1, retryAfter = -1|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_ACTIVE]|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Created TCB: 0xfc40f90|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB 0xfc40f90's parent is 0xfc47520|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present: TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB 0xfc40f90's method is 111|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB(0xfc40f90) has claimed possesion of package (0x87cd6010)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d158d09cb8|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0xfc47520/Entering ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc40f90) on EDB(0x8a708608)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0xfc47520/There are 1 TCB's on tcbQ|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc40f90 and parent: 0xfc47520
|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/msg=0x87cd6010, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/gcb=0xfc47520 is already on connection=0x13621d40 context_list|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/Set to send the msg=0x87cd6010|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/Posting send for msg=0x87cd6010, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc40f90) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Created timer context(0xa924ccd8)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.505 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.505 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522381,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d158d09cb8
From: <sip:805243375@10.2.50.8>;tag=1321680832
To: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 102 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Subscription-State: terminated;reason=deactivated
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Length: 0
Some one is a SIP exper here?
Reggards.
10:59:48.034 |DMMS: (0000832) - isMobileClientDMIConfigured, no MI configured|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) checkSingleRegRequest -- dual registration case|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) SIPRegisterInd, dual registration case. MtPreferredMode = 0, oldMtPreferredMode = 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) checkNoMIDeviceRegRequest -- no MI case: good dual registration message|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.034 |DMMS: (0000832) SIPRegisterInd, device name = BOTL01460667, sipstationd connection index=38816|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.036 |<MN::Directory Number><MV::805243375>|0,0,0,0.0^*^*
10:59:48.038 |SIPEventPkg::subscribeReq address list is NOT empty|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |getCcdSafRouteFromAddrList SafTransAddrList is empty|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |SIPEventPkg::subscribeReq exp = 33776 t = 31976 caller = 805243375, callee = ac821ca7-6099-1e40-eb68-daf6308972c9|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |LineControl(123817) - BOTL01460667 registered, CEPN=263d118e-aa8c-e49f-7f0f-856023fcf7b1, deviceType=8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |No associated device or user.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.038 |LineControl(123817) - 0 calls, 0 CiReq, busyTrigger=2, maxCall=3|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 3 for event 42|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Associated container=0x87787448 to REGISTER Response 200|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Sending INFO Response to the transport layer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/msg=0x18d9c4d0, addr=10.32.100.111, port=60372, sentBy_port=60372, is_req=0, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Trying to send resp=0x18d9c4d0 to default port=60372|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gcb=0xfc2e818 is already on connection=0x13621d40 context_list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0xfc2e818/Connection obtained...sending msg=0x18d9c4d0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Posting send for msg=0x18d9c4d0, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/****Deleting from UAS Request table.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Deleting from table. ccb=0xfc2e818 key=00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111805243375000000000000000235e26b14-1d7941af|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Removing call id 3f79d3|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Context for key=[4157366] removed.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/There are 0 events on the internal queue that are going to be free'd|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gConnTab=0xf13f240, addr=10.32.100.111, port=60372, unregistering context=0xfc2e818|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Purging context gcb=0xfc2e818 from the connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc2e818/Freeing ccb fc2e818|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/NO context for key[4157366]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/gcb has cleanedup, Done with send operations for this context|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/NO context for key[4157366]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |DeviceManager::star_DmUpdateRoamingInfo - DeviceMobility is disabled for the device = [BOTL01460667], Checking if we need to de-associate Roaming Device Pool.|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |DeviceManager::star_DmUpdateRoamingInfo - Roaming Device pool is empty or null|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522367,NET]
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.32.100.111:60372;branch=z9hG4bK0a646f97
From: <sip:805243375@10.2.50.8>;tag=000000000000000235e26b14-1d7941af
To: <sip:805243375@10.2.50.8>;tag=1438577607
Date: Fri, 24 May 2013 15:59:48 GMT
Call-ID: 00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111
CSeq: 101 REGISTER
Expires: 660
Contact: <sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=tcp>;+sip.instance="<urn:uuid:00000000-0000-0000-0000-000000000000>";+sip.instance="<urn:uuid:00000000-0000-0000-0000-000000000000>";+u.sip!devicename.ccm.cisco.com="BOTL01460667";+u.sip!model.ccm.cisco.com="575";x-cisco-newreg
Supported: X-cisco-srtp-fallback,X-cisco-sis-5.2.0
Content-Length: 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159957|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Added context(0xfc42a80) with key=[4157367] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=4159957/ccsip_platform_init_scb: scb mgmt added 0xfc42a80 (context_id=4157367)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Created new scb: 0xfc42a80 with id: 4159957|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 209|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_REFER] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Inserting SCB with key 4159957 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41b10|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0x0/TCB 0xfc41b10's parent is 0xfc42a80|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Info/0xfc42a80/Initiating Out-Of-Call-Context Refer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.039 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba6-832020a@10.2.50.8542272426|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/Inserting SCB with key f4687780-19f18e74-1ba6-832020a@10.2.50.8542272426 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/No registrar cfg. Using default value for refby host : 10.2.50.8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc41b10's method is 110|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB(0xfc41b10) has claimed possesion of package (0x880f99c0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d0f36113e06|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created new edb(0xfc49a90)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/EDB updated with Event Name: refer Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/Q'd EDB(0xfc49a90) on SCB(0xfc42a80)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41b10) on EDB(0xfc49a90)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0xfc42a80/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41b10 and parent: 0xfc42a80
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/msg=0x880f99c0, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc42a80 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0xfc42a80/Set to send the msg=0x880f99c0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Posting send for msg=0x880f99c0, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41b10) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created timer context(0x856f2228)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522368,NET]
REFER sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d0f36113e06
From: <sip:805243375@10.2.50.8>;tag=542272426
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba6-832020a@10.2.50.8
CSeq: 101 REFER
Max-Forwards: 70
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
User-Agent: Cisco-CUCM8.6
Require: norefersub
Expires: 0
Refer-To: cid:1234567890@10.2.50.8
Content-Id: <1234567890@10.2.50.8>
Content-Type: application/x-cisco-remotecc-request+xml
Referred-By: <sip:805243375@10.2.50.8>
Content-Length: 193
<x-cisco-remotecc-request> <cfwdallupdate>
<linenumber>1</linenumber>
<fwdaddress></fwdaddress>
<tovoicemail>off</tovoicemail>
</cfwdallupdate></x-cisco-remotecc-request>|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159958|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Added context(0x87f6a360) with key=[4157368] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=4159958/ccsip_platform_init_scb: scb mgmt added 0x87f6a360 (context_id=4157368)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Created new scb: 0x87f6a360 with id: 4159958|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Inserting SCB with key 4159958 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created TCB: 0xfc419a0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc419a0's parent is 0x87f6a360|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba7-832020a@10.2.50.81779673145|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Inserting SCB with key f4687780-19f18e74-1ba7-832020a@10.2.50.81779673145 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB 0xfc419a0's method is 111|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/TCB(0xfc419a0) has claimed possesion of package (0x888842e8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d102c019479|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Created new edb(0xfc49bf0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/EDB updated with Event Name: service-control Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/Q'd EDB(0xfc49bf0) on SCB(0x87f6a360)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc419a0) on EDB(0xfc49bf0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x87f6a360/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.040 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc419a0 and parent: 0x87f6a360
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/msg=0x888842e8, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Registering gcb=0x87f6a360 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x87f6a360/Set to send the msg=0x888842e8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Posting send for msg=0x888842e8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc419a0) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created timer context(0x85d29cc0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522369,NET]
NOTIFY sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d102c019479
From: <sip:10.2.50.8>;tag=1779673145
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba7-832020a@10.2.50.8
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: service-control
Subscription-State: active
Contact: <sip:10.2.50.8:5060;transport=tcp>
Content-Type: text/plain
Content-Length: 283action=check-version
RegisterCallId={00000000-00000003-08fd3c50-1e4f0f28@10.32.100.111}
ConfigVersionStamp={1369411077-ca34b1ee-c054-4947-ae19-3398608276d1}
DialplanVersionStamp={}
SoftkeyVersionStamp={}
FeatureControlVersionStamp={0000000000-c7a6c673-7479-46b0-839e-014d3d093963}|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159959|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Added context(0x8a96ba38) with key=[4157369] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=4159959/ccsip_platform_init_scb: scb mgmt added 0x8a96ba38 (context_id=4157369)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Created new scb: 0x8a96ba38 with id: 4159959|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 209|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_REFER] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Inserting SCB with key 4159959 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41830|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB 0xfc41830's parent is 0x8a96ba38|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Initiating Out-Of-Call-Context Refer|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba8-832020a@10.2.50.8907362330|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Inserting SCB with key f4687780-19f18e74-1ba8-832020a@10.2.50.8907362330 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/No registrar cfg. Using default value for refby host : 10.2.50.8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB 0xfc41830's method is 110|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/TCB(0xfc41830) has claimed possesion of package (0x87c47e70)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d11da64ca9|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created new edb(0xb0974110)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/EDB updated with Event Name: refer Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/Q'd EDB(0xb0974110) on SCB(0x8a96ba38)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41830) on EDB(0xb0974110)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x8a96ba38/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41830 and parent: 0x8a96ba38
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/msg=0x87c47e70, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Registering gcb=0x8a96ba38 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x8a96ba38/Set to send the msg=0x87c47e70|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Transport/0x0/Posting send for msg=0x87c47e70, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41830) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Created timer context(0x877019d8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.041 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522370,NET]
REFER sip:805243375@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d11da64ca9
From: <sip:805243375@10.2.50.8>;tag=907362330
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba8-832020a@10.2.50.8
CSeq: 101 REFER
Max-Forwards: 70
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
User-Agent: Cisco-CUCM8.6
Require: norefersub
Expires: 0
Refer-To: cid:1234567890@10.2.50.8
Content-Id: <1234567890@10.2.50.8>
Content-Type: application/x-cisco-remotecc-request+xml
Referred-By: <sip:805243375@10.2.50.8>
Content-Length: 133<x-cisco-remotecc-request>
<dndupdate>
<state>disable</state>
<option>callreject</option>
</dndupdate>
</x-cisco-remotecc-request>|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159960|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Added context(0xfc436f0) with key=[4157370] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=4159960/ccsip_platform_init_scb: scb mgmt added 0xfc436f0 (context_id=4157370)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Created new scb: 0xfc436f0 with id: 4159960|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Inserting SCB with key 4159960 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41c80|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41c80's parent is 0xfc436f0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1ba9-832020a@10.2.50.81491309815|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Inserting SCB with key f4687780-19f18e74-1ba9-832020a@10.2.50.81491309815 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41c80's method is 111|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB(0xfc41c80) has claimed possesion of package (0x85ff1f00)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d122e1d329c|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created new edb(0xfc49eb0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/EDB updated with Event Name: message-summary Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/Q'd EDB(0xfc49eb0) on SCB(0xfc436f0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41c80) on EDB(0xfc49eb0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc436f0/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41c80 and parent: 0xfc436f0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/msg=0x85ff1f00, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc436f0 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0xfc436f0/Set to send the msg=0x85ff1f00|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85ff1f00, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41c80) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created timer context(0x888c3be8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522371,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d122e1d329c
From: <sip:805243375@10.2.50.8>;tag=1491309815
To: <sip:805243375@10.32.100.111>
Call-ID: f4687780-19f18e74-1ba9-832020a@10.2.50.8
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: message-summary
Subscription-State: active
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Type: application/simple-message-summary
Content-Length: 22Messages-Waiting: no
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159956|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Added context(0xfc468b0) with key=[4157371] to table|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=4159956/ccsip_platform_init_scb: scb mgmt added 0xfc468b0 (context_id=4157371)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Created new scb: 0xfc468b0 with id: 4159956|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/SIPHandler/ccbId=0/scbId=0/populateTargetInfo: port=60372, isIPAddr=1, type=2, target_port=5060, outboundProxyAddr.isIPAddr=0, target_type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 205|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_SUBSCRIBE] received in State [SUBSCRIBE_STATE_IDLE]|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Inserting SCB with key 4159956 into SubIDTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41270|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/TCB 0xfc41270's parent is 0xfc468b0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Initiating Out-Of-Call-Context Subscription|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0x0/Generated Subscribe Key : f4687780-19f18e74-1baa-832020a@10.2.50.8263107937|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.042 |//SIP/Stack/Info/0xfc468b0/Inserting SCB with key f4687780-19f18e74-1baa-832020a@10.2.50.8263107937 into ClientTable|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/TCB 0xfc41270's method is 112|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/TCB(0xfc41270) has claimed possesion of package (0x85a73af8)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d136ff69e|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Created new edb(0xfc4a2d0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/EDB updated with Event Name: dialog Event ID: |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/Q'd EDB(0xfc4a2d0) on SCB(0xfc468b0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/There are 1 EDB's on edbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41270) on EDB(0xfc4a2d0)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0xfc468b0/There are 1 TCB's on tcbQ|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41270 and parent: 0xfc468b0
|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/msg=0x85a73af8, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/Proceedable for sending msg immediately|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/switch transport is 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc468b0 with connection=0x13621d40 context list|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0xfc468b0/Set to send the msg=0x85a73af8|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85a73af8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41270) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Created timer context(0x8506de20)|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_IDLE to state SUBSCRIBE_STATE_DIALOG_PENDING|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.043 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522372,NET]
SUBSCRIBE sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372 SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d136ff69e
From: <sip:805243375@10.2.50.8>;tag=263107937
To: <sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111>
Call-ID: f4687780-19f18e74-1baa-832020a@10.2.50.8
CSeq: 101 SUBSCRIBE
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Expires: 33776
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Accept: application/dialog-info+xml
Max-Forwards: 69
Content-Length: 0|5,100,63,1.4157357^10.32.100.111^BOTL01460667
10:59:48.080 |SIPStationInit: connID=38816, BOTL01460667, 10.32.100.111:60372, Routed signal by connection index to (5,100,199,832)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::subscribeInd exp = 42128, t = 43928|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::notifierRouteAndAuthorize|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::sendSIPSubResponse 200|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |SIPEventPkg::notifierNotifyReq|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 203|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_SUBSCRIBE_RESP] received in State [SUBSCRIBE_STATE_DIALOG_PENDING]|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/TCB(0xfc413e0) has claimed possesion of package (0x85af6cb8)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc413e0 and parent: 0xfc47520
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/msg=0x85af6cb8, addr=10.32.100.111, port=60372, sentBy_port=60372, is_req=0, transport=2, switch=0, callBack=|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Trying to send resp=0x85af6cb8 to default port=60372|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0x0/Registering gcb=0xfc47520 with connection=0x13621d40 context list|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0xfc47520/Connection obtained...sending msg=0x85af6cb8|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85af6cb8, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBServer...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Sizeof tcbQ: 1|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/DeQ'd TCB(0xfc413e0) from EDB(0x8a708608)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/EnQing TCB(0xfc413e0) for reuse|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Changing from State: SUBSCRIBE_STATE_DIALOG_PENDING to state SUBSCRIBE_STATE_ACTIVE|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522374,NET]
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.32.100.111:60372;branch=z9hG4bK14f07032
From: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
To: <sip:805243375@10.2.50.8>;tag=1321680832
Date: Fri, 24 May 2013 15:59:48 GMT
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 1000 SUBSCRIBE
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Expires: 42128
Content-Length: 0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.080 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_ACTIVE]|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Created TCB: 0xfc41100|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB 0xfc41100's parent is 0xfc47520|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present: TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB 0xfc41100's method is 111|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/TCB(0xfc41100) has claimed possesion of package (0x85a27518)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d1451d19f9c|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0xfc47520/Entering ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc41100) on EDB(0x8a708608)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0xfc47520/There are 1 TCB's on tcbQ|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc41100 and parent: 0xfc47520
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/msg=0x85a27518, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/gcb=0xfc47520 is already on connection=0x13621d40 context_list|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0xfc47520/Set to send the msg=0x85a27518|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Transport/0x0/Posting send for msg=0x85a27518, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc41100) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/Stack/Info/0x0/Created timer context(0x856375c8)|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.081 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522375,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d1451d19f9c
From: <sip:805243375@10.2.50.8>;tag=1321680832
To: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 101 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Subscription-State: active;expires=42128
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Type: application/dialog-info+xml
Content-Length: 266<dialog-info xmlns="urn:ietf:parmams:xml:ns:dialog-info"
xmlns:call="urn:x-cisco:parmams:xml:ns:dialog-info:dialog:callinfo-dialog"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
version="1" state="full" entity="sip:805243375@10.2.50.8">
</dialog-info>
|5,100,63,1.4157358^10.32.100.111^BOTL01460667
10:59:48.504 |SIPStationInit: connID=38816, BOTL01460667, 10.32.100.111:60372, Routed signal by connection index to (5,100,199,832)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::notifierNotifyResult result = 400 termNot not sent continuing|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::notifierNotifyResult result = 400|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg::stop mStopped=false|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |SIPEventPkg:sendExternalFinalNotify state = 3 reason = 1, retryAfter = -1|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Searching for SCB in subID table with key 4159961|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/ccsip_spi_get_msg_type returned: 7 for event 204|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Event [SIPSPI_EV_CC_NOTIFY] received in State [SUBSCRIBE_STATE_ACTIVE]|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Created TCB: 0xfc40f90|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB 0xfc40f90's parent is 0xfc47520|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/Dialog Transaction Address 10.32.100.111,Port 60372, Port Present: TRUE, Transport 2, FQDN 183214202|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB 0xfc40f90's method is 111|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/TCB(0xfc40f90) has claimed possesion of package (0x87cd6010)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Client TCB's Marker Updated to: z9hG4bK3d158d09cb8|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0xfc47520/Entering ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Q'd TCB(0xfc40f90) on EDB(0x8a708608)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0xfc47520/There are 1 TCB's on tcbQ|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Entering ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Sending Package on tcb: 0xfc40f90 and parent: 0xfc47520
|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/msg=0x87cd6010, addr=10.32.100.111, port=60372, sentBy_port=0, is_req=1, transport=2, switch=0, callBack=|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/Proceedable for sending msg immediately|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/switch transport is 0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/gcb=0xfc47520 is already on connection=0x13621d40 context_list|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0xfc47520/Set to send the msg=0x87cd6010|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Transport/0x0/Posting send for msg=0x87cd6010, addr=10.32.100.111, port=60372, connId=38816 for TCP|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/findTrunkInfoByAddr: Cannot find the SIP Trunk with Name=10.32.100.111, Source Port=5060, IpAddress Type=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Entering sipSPISentTCBClient...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Kicking off ReTx Timer for Client TCB (0xfc40f90) with 0 retries and 32000 milliseconds initial retx |5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/Stack/Info/0x0/Created timer context(0xa924ccd8)|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_stop_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.504 |//SIP/SIPHandler/ccbId=0/scbId=0/sip_start_timer: type=SIP_TIMER_CLIENT_TCB value=32000 retries=0|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.505 |//SIP/SIPTcp/wait_SdlSPISignal: received a spi signal ...|5,100,63,1.4157361^10.32.100.111^BOTL01460667
10:59:48.505 |//SIP/SIPTcp/wait_SdlSPISignal: Outgoing SIP TCP message to 10.32.100.111 on port 60372 index 38816
[12522381,NET]
NOTIFY sip:ac821ca7-6099-1e40-eb68-daf6308972c9@10.32.100.111:60372;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 10.2.50.8:5060;branch=z9hG4bK3d158d09cb8
From: <sip:805243375@10.2.50.8>;tag=1321680832
To: "3375 - Aldo Soto" <sip:805243375@10.32.100.111>;tag=00000000000000034b1786de-1fd70bfb
Call-ID: 00000000-00000002-6f93be50-56293e62@10.32.100.111
CSeq: 102 NOTIFY
Max-Forwards: 70
Date: Fri, 24 May 2013 15:59:48 GMT
User-Agent: Cisco-CUCM8.6
Event: dialog
Subscription-State: terminated;reason=deactivated
Contact: <sip:805243375@10.2.50.8:5060;transport=tcp>
Content-Length: 0
- Labels:
-
Jabber
Find answers to your questions by entering keywords or phrases in the Search bar above. New here? Use these resources to familiarize yourself with the community: