VOIP_NETSER#debug voice ccapi inout
voip ccapi inout debugging is on
VOIP_NETSER#debug vpm signal
Voice Port Module signaling debugging is enabled
VOIP_NETSER#
VOIP_NETSER#
*Jun 23 16:25:27.127: htsp_process_event: [0/1/0, FXOLS_ONHOOK, E_DSP_SIG_0000]fxols_onhook_ringing
*Jun 23 16:25:27.127: htsp_timer - 125 msec
*Jun 23 16:25:27.255: htsp_process_event: [0/1/0, FXOLS_WAIT_RING_MIN, E_HTSP_EVENT_TIMER]fxols_wait_ring_min_timer
*Jun 23 16:25:27.255: htsp_timer - 10000 msec
*Jun 23 16:25:27.303: htsp_process_event: [0/1/0, FXOLS_RINGING, E_DSP_SIG_0110]
*Jun 23 16:25:27.487: htsp_process_event: [0/1/0, FXOLS_RINGING, E_DSP_SIG_0100]
*Jun 23 16:25:27.487: fxols_ringing_not
*Jun 23 16:25:27.487: htsp_timer_stop
*Jun 23 16:25:27.487: htsp_timer_stop3 htsp_setup_ind
*Jun 23 16:25:27.487: [0/1/0] get_local_station_id calling num= calling name= calling time=06/23 16:25  orig called=
*Jun 23 16:25:27.491: //-1/4AC3E54F807F/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=3544569
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Jun 23 16:25:27.491: //-1/4AC3E54F807F/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x86FD4494, Call Info(
   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=0, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=FALSE,
   Source Trkgrp Route Label=FXO, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
*Jun 23 16:25:27.491: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.491: :cc_get_feature_vsa malloc success
*Jun 23 16:25:27.491: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.491:  cc_get_feature_vsa count is 1
*Jun 23 16:25:27.491: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.491: :FEATURE_VSA attributes are: feature_name:0,feature_time:2248299280,feature_id:72
*Jun 23 16:25:27.491: //39/4AC3E54F807F/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown))
*Jun 23 16:25:27.491: htsp_process_event: [0/1/0, FXOLS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]
*Jun 23 16:25:27.491: fxols_wait_setup_ack:
*Jun 23 16:25:27.491: htsp_timer - 6000 msec
*Jun 23 16:25:27.491: //39/4AC3E54F807F/CCAPI/cc_process_call_setup_ind:
   Event=0x878679B0
*Jun 23 16:25:27.491: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 3544569
*Jun 23 16:25:27.495: //39/4AC3E54F807F/CCAPI/ccCallSetContext:
   Context=0x85F21360
*Jun 23 16:25:27.495: //39/4AC3E54F807F/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 39 with tag 0 to app "_ManagedAppProcess_Default"
*Jun 23 16:25:27.495: //39/4AC3E54F807F/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=FALSE, Mode=0,
   Outgoing Dial-peer=100, Params=0x85F226B8, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccCheckClipClir:
   In: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccCheckClipClir:
   Out: Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccCallSetupRequest:
   Destination Pattern=3544569, Called Number=3544569, Digit Strip=FALSE
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccCallSetupRequest:
   Calling Number=(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=, Final Destination Flag=TRUE,
   Guid=4AC3E54F-18FB-11E5-807F-B83E57223CCF, Outgoing Dial-peer=100
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=3544569
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x86CF5C74, Interface Type=1, Destination=, Mode=0x0,
   Call Params(Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=TRUE, Outgoing Dial-peer=100, Call Count On=FALSE,
   Source Trkgrp Route Label=FXO, Target Trkgrp Route Label=, tg_label_flag=1, Application Call Id=)
*Jun 23 16:25:27.499: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.499: :cc_get_feature_vsa malloc success
*Jun 23 16:25:27.499: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.499:  cc_get_feature_vsa count is 2
*Jun 23 16:25:27.499: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.499: :FEATURE_VSA attributes are: feature_name:0,feature_time:2248299056,feature_id:73
*Jun 23 16:25:27.499: //40/4AC3E54F807F/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=1, FlowMode=1
*Jun 23 16:25:27.499: //40/4AC3E54F807F/CCAPI/ccCallSetContext:
   Context=0x85F22668
*Jun 23 16:25:27.499: //39/4AC3E54F807F/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=100
*Jun 23 16:25:27.499: htsp_process_event: [0/1/0, FXOLS_PROCEEDING, E_HTSP_PROCEEDING]fxols_offhook_proc
*Jun 23 16:25:27.507: //-1/4AC3E54F807F/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=VOIP_NETSER
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=3544569
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=-1
   cisco-rdnplan=-1
   cisco-rdnpi=-1
   cisco-rdnsi=-1
   cisco-redirectreason=-1   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0

*Jun 23 16:25:27.507: //-1/4AC3E54F807F/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x86CF5C74, Call Info(
   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
   Incoming Dial-peer=100, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=FALSE,
   Source Trkgrp Route Label=FXO, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=41
*Jun 23 16:25:27.507: //-1/4AC3E54F807F/CCAPI/ccCheckClipClir:
   In: Calling Number=3544569(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 23 16:25:27.507: //-1/4AC3E54F807F/CCAPI/ccCheckClipClir:
   Out: Calling Number=3544569(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
*Jun 23 16:25:27.507: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.507: :cc_get_feature_vsa malloc success
*Jun 23 16:25:27.507: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.507:  cc_get_feature_vsa count is 3
*Jun 23 16:25:27.507: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jun 23 16:25:27.507: :FEATURE_VSA attributes are: feature_name:0,feature_time:2248298832,feature_id:74
*Jun 23 16:25:27.507: //41/4AC3E54F807F/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=3544569(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=3544569(TON=Unknown, NPI=Unknown))
*Jun 23 16:25:27.511: //41/4AC3E54F807F/CCAPI/cc_process_call_setup_ind:
   Event=0x878679B0
*Jun 23 16:25:27.511: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
   Try with the demoted called number 3544569
*Jun 23 16:25:27.527: //41/4AC3E54F807F/CCAPI/ccCallSetContext:
   Context=0x85F0F5E8
*Jun 23 16:25:27.527: //41/4AC3E54F807F/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 41 with tag 100 to app "_ManagedAppProcess_cme-aa"
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccCallSetupAck:
   Call Id=41
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/cc_api_set_transfer_info:
   Transfer Number=, Transfer Reason=0x0
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x0
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=20000(ms), Inter Digit Timeout=-1000(ms)
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=20000(ms))
*Jun 23 16:25:27.535: //41/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x29, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:25:27.535: //41/4AC3E54F807F/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=41
*Jun 23 16:25:27.627: //41/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x86CF5C74, callID=0x29, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:25:27.627: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:25:27.627: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=20000(ms), Inter Digit Timeout=10000(ms))
*Jun 23 16:25:27.663: //40/4AC3E54F807F/CCAPI/cc_api_call_proceeding:
   Interface=0x86CF5C74, Progress Indication=NULL(0)
*Jun 23 16:25:27.667: //40/4AC3E54F807F/CCAPI/cc_api_call_connected:
   Interface=0x86CF5C74, Data Bitmask=0x0, Progress Indication=NULL(0),
   Connection Handle=0
*Jun 23 16:25:27.667: //40/4AC3E54F807F/CCAPI/cc_api_call_connected:
   Call Entry(Connected=TRUE, Responsed=TRUE, Retry Count=0)
*Jun 23 16:25:27.743: //39/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x85F0998C, callID1=0x27, callID2=0x28, tag=0x0)
*Jun 23 16:25:27.743: //39/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x85F0998C, callID1=0x27, gcid=4AC3E54F-18FB11E5-807FB83E-57223CCF, tag=0x0)
*Jun 23 16:25:27.743: //40/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x85F0998C, callID2=0x28, gcid=4AC3E54F-18FB11E5-807FB83E-57223CCF, tag=0x0)
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/ccConferenceCreate:
   Conference Id=0x85F0998C, Call Id1=39, Call Id2=40, Tag=0x0
*Jun 23 16:25:27.743: htsp_call_bridged invoked
*Jun 23 16:25:27.743: //39/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC, Source Interface=0x86FD4494, Source Call Id=39,
   Destination Call Id=40, Disposition=0x0, Tag=0xFFFFFFFF
*Jun 23 16:25:27.743: //40/xxxxxxxxxxxx/CCAPI/cc_api_get_xcode_stream:

*Jun 23 16:25:27.743: cc_api_get_xcode_stream : 4534
*Jun 23 16:25:27.743: //40/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC, Source Interface=0x86CF5C74, Source Call Id=40,
   Destination Call Id=39, Disposition=0x0, Tag=0x0
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC, Source Interface=0x86CF5C74, Source Call Id=40,
   Destination Call Id=39, Disposition=0x0, Tag=0x0
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC, Destination Call Id=40)
*Jun 23 16:25:27.743: //40/4AC3E54F807F/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC, Destination Call Id=39)
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Destination Interface=0x86CF5C74, Destination Call Id=40, Source Call Id=39,
   Caps(Codec=0x1, Fax Rate=0x1, Vad=0x1,
   Modem=0x2, Codec Bytes=20, Signal Type=3)
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/ccCallConnect:
   Progress Indication=NULL(0), Data Bitmask=0x0
*Jun 23 16:25:27.743: //39/4AC3E54F807F/CCAPI/ccCallConnect:
   Call Entry(Connected=TRUE, Responsed=TRUE)
*Jun 23 16:25:27.743: htsp_process_event: [0/1/0, FXOLS_PROCEEDING, E_HTSP_CONNECT]fxols_offhook_connect
*Jun 23 16:25:27.743: [0/1/0] set signal state = 0xC timestamp = 0
*Jun 23 16:25:27.743: htsp_timer_stop
*Jun 23 16:25:27.747: //39/4AC3E54F807F/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0xC, Call Id1=39, Call Id2=40
*Jun 23 16:25:27.747: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x1,
   Modem=0x0, Codec Bytes=160, Signal Type=2)
*Jun 23 16:25:27.747: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
*Jun 23 16:25:27.747: //40/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.747: //39/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86CF5C74, Destination Call Id=40, Source Call Id=39,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x1,
   Modem=0x0, Codec Bytes=160, Signal Type=2)
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x1,
   Modem=0x0, Codec Bytes=160, Signal Type=2)
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
*Jun 23 16:25:27.751: //40/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86FD4494, Destination Call Id=39, Source Call Id=40,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86CF5C74, Destination Call Id=40, Source Call Id=39,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_caps_ack:
   Destination Interface=0x86CF5C74, Destination Call Id=40, Source Call Id=39,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
   Modem=OFF(0x0), Codec Bytes=160, Signal Type=2, Seq Num Start=689)
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Id=39
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x85F21360)
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Id=39
*Jun 23 16:25:27.751: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x85F21360)
*Jun 23 16:25:27.751: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice
*Jun 23 16:25:27.755: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice
*Jun 23 16:25:27.755: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Id=39
*Jun 23 16:25:27.755: //39/4AC3E54F807F/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x85F21360)
*Jun 23 16:25:27.755: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_HTSP_VOICE_CUT_THROUGH]fxols_connect_proc_voice
*Jun 23 16:25:27.791: //41/4AC3E54F807F/CCAPI/ccAssociateStream:
   Coder=5, DTMF Relay=1, Vad=0,
   Record Function=0x0, Event Queue=0x87384964, Stream Context=8885E8F0,
   Record Context=0x0, Stream Call Id=42, Call Id=41
*Jun 23 16:25:27.791: //41/4AC3E54F807F/CCAPI/ccAssociateStream:
   Call Entry(Stream Status=2, Digit Enable=TRUE)
*Jun 23 16:25:27.791: //41/4AC3E54F807F/CCAPI/cc_api_call_associated:

VOIP_NETSER#Interface=0x0, CallId=41, Disposition=0
   Play Function=0x83437818, Codec=0x5, Vad=0x0
   Media Type=0x1, SPI Context=0x88CEFEC0, Stream CallId=42
   TX Dynamic Pt=0xFF, RX Dynamic Pt=0xFF
*Jun 23 16:25:27.795: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:
   Record Context=0x0, Stream Call Id=42, Call Id=41
*Jun 23 16:25:27.795: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:
   Call Entry(Stream Status=1, Digit Enable=TRUE)
*Jun 23 16:25:28.015: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_DSP_SIG_0110]fxols_rvs_battery
*Jun 23 16:25:28.015: htsp_timer_stop2
VOIP_NETSER#
*Jun 23 16:25:37.623: //41/4AC3E54F807F/CCAPI/cc_api_call_info:
   Info Digits=, Info Complete=TRUE,
   Interface=0x86CF5C74, Data Bitmask=0x0, Call Id=41
*Jun 23 16:25:38.579: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc
*Jun 23 16:25:38.579: htsp_timer2 - 350 msec
VOIP_NETSER#
*Jun 23 16:25:38.631: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_DSP_SIG_0100]fxols_normal_battery
*Jun 23 16:25:38.631: htsp_timer_stop2
VOIP_NETSER#
*Jun 23 16:25:47.795: //41/4AC3E54F807F/CCAPI/cc_handle_inter_digit_timer:
   Generate inter-digit timeout CC_EV_CALL_DIGIT_END event
*Jun 23 16:25:47.795: //41/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x29, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jun 23 16:25:47.795: //41/4AC3E54F807F/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=41
*Jun 23 16:25:47.795: //41/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x86CF5C74, callID=0x29, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jun 23 16:25:47.795: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:25:47.795: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=20000(ms), Inter Digit Timeout=10000(ms))
*Jun 23 16:25:47.795: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=20000(ms), Inter Digit Timeout=-1000(ms)
*Jun 23 16:25:47.799: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=20000(ms))
*Jun 23 16:25:47.799: //41/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x29, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:25:47.799: //41/4AC3E54F807F/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=41
*Jun 23 16:25:47.799: //41/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x86CF5C74, callID=0x29, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:25:47.799: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:25:47.799: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=20000(ms), Inter Digit Timeout=10000(ms))
*Jun 23 16:25:47.851: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:
   Record Context=0x0, Stream Call Id=42, Call Id=41
*Jun 23 16:25:47.851: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:

VOIP_NETSER#Call Entry(Stream Status=1, Digit Enable=TRUE)
VOIP_NETSER#
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/cc_handle_inter_digit_timer:
   Generate inter-digit timeout CC_EV_CALL_DIGIT_END event
*Jun 23 16:26:07.851: //41/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x29, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=41
*Jun 23 16:26:07.851: //41/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x86CF5C74, callID=0x29, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=20000(ms), Inter Digit Timeout=10000(ms))
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=20000(ms), Inter Digit Timeout=-1000(ms)
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=20000(ms))
*Jun 23 16:26:07.851: //41/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x29, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:26:07.851: //41/4AC3E54F807F/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=41
*Jun 23 16:26:07.851: //41/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x86CF5C74, callID=0x29, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
*Jun 23 16:26:07.855: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:26:07.855: //41/4AC3E54F807F/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=20000(ms), Inter Digit Timeout=10000(ms))
*Jun 23 16:26:07.903: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:
   Record Context=0x0, Stream Call Id=42, Call Id=41
*Jun 23 16:26:07.903: //41/4AC3E54F807F/CCAPI/ccDisassociateStream:

VOIP_NETSER#Call Entry(Stream Status=1, Digit Enable=TRUE)
*Jun 23 16:26:08.939: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_DSP_SIG_1100]fxols_offhook_disc
*Jun 23 16:26:08.939: htsp_timer2 - 350 msec
*Jun 23 16:26:09.291: htsp_process_event: [0/1/0, FXOLS_CONNECT, E_HTSP_EVENT_TIMER2]fxols_disc_confirm
*Jun 23 16:26:09.291: htsp_timer_stop
*Jun 23 16:26:09.291: htsp_timer_stop2
*Jun 23 16:26:09.291: htsp_timer_stop3
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x86FD4494, Call Id=39
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/ccConferenceDestroy:
   Conference Id=0xC, Tag=0x0
*Jun 23 16:26:09.291: //39/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC, Source Interface=0x86FD4494, Source Call Id=39,
   Destination Call Id=40, Disposition=0x0, Tag=0x0
*Jun 23 16:26:09.291: //40/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC, Source Interface=0x86CF5C74, Source Call Id=40,
   Destination Call Id=39, Disposition=0x0, Tag=0x0
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC, Source Interface=0x86CF5C74, Source Call Id=40,
   Destination Call Id=39, Disposition=0x0, Tag=0x0
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jun 23 16:26:09.291: //39/4AC3E54F807F/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jun 23 16:26:09.291: //40/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Jun 23 16:26:09.291: //40/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jun 23 16:26:09.291: //40/4AC3E54F807F/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jun 23 16:26:09.291: htsp_timer_stop3
*Jun 23 16:26:09.295: //40/4AC3E54F807F/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jun 23 16:26:09.299: //40/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x86CF5C74, Tag=0x0, Call Id=40,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jun 23 16:26:09.299: //40/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Jun 23 16:26:09.299: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.299: :cc_free_feature_vsa freeing 86025228
*Jun 23 16:26:09.299: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.299:  vsacount in free is 2
*Jun 23 16:26:09.299: //41/4AC3E54F807F/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x86CF5C74, Call Id=41
*Jun 23 16:26:09.299: //41/4AC3E54F807F/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
*Jun 23 16:26:09.303: //41/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
*Jun 23 16:26:09.303: //41/4AC3E54F807F/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
*Jun 23 16:26:09.303: //41/4AC3E54F807F/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
*Jun 23 16:26:09.303: //41/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x86CF5C74, Tag=0x0, Call Id=41,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jun 23 16:26:09.303: //41/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
*Jun 23 16:26:09.303: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.303: :cc_free_feature_vsa freeing 86025148
*Jun 23 16:26:09.303: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.303:  vsacount in free is 1
*Jun 23 16:26:09.307: htsp_process_event: [0/1/0, FXOLS_REMOTE_RELEASE, E_HTSP_RELEASE_REQ]fxols_offhook_release
*Jun 23 16:26:09.307: htsp_timer_stop
*Jun 23 16:26:09.307: htsp_timer_stop2
*Jun 23 16:26:09.307: htsp_timer_stop3
*Jun 23 16:26:09.307: [0/1/0] set signal state = 0x4 timestamp = 0
*Jun 23 16:26:09.307: htsp_timer - 2000 msec
*Jun 23 16:26:09.311: //39/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x86FD4494, Tag=0x0, Call Id=39,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jun 23 16:26:09.311: //39/4AC3E54F807F/CCAPI/cc_api_call_disconnect_done:

VOIP_NETSER#Call Disconnect Event Sent
*Jun 23 16:26:09.311: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.311: :cc_free_feature_vsa freeing 86025308
*Jun 23 16:26:09.311: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jun 23 16:26:09.311:  vsacount in free is 0
VOIP_NETSER#
*Jun 23 16:26:11.307: htsp_process_event: [0/1/0, FXOLS_GUARD_OUT, E_HTSP_EVENT_TIMER]fxols_guard_out_timeout
*Jun 23 16:26:11.307: htsp_process_event: [0/1/0, FXOLS_ONHOOK, E_DSP_SIG_0100]
VOIP_NETSER#